builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1469463621.29 results: success (0) buildid: 20160725055525 builduid: 1a746a1fe5174b1eafb83b4820e16575 revision: bc767d7a30ddb701a9b2bd62670fdbe14780f81f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.292452) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.292968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.293289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.309704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.310136) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 09:20:21-- 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% 113M=0s 2016-07-25 09:20:21 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100203 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.429137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.429450) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020830 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.480800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:21.481195) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bc767d7a30ddb701a9b2bd62670fdbe14780f81f --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 bc767d7a30ddb701a9b2bd62670fdbe14780f81f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 09:20:21,997 truncating revision to first 12 chars 2016-07-25 09:20:21,997 Setting DEBUG logging. 2016-07-25 09:20:21,997 attempt 1/10 2016-07-25 09:20:21,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bc767d7a30dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 09:20:22,324 unpacking tar archive at: autoland-bc767d7a30dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:22.208373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:22.208689) ========= script_repo_revision: bc767d7a30ddb701a9b2bd62670fdbe14780f81f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:22.209077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:22.209347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 09:20:22.220220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-25 09:20:22.220539) ========= /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=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:20:22 INFO - MultiFileLogger online at 20160725 09:20:22 in /builds/slave/test 09:20:22 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 09:20:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:22 INFO - {'append_to_log': False, 09:20:22 INFO - 'base_work_dir': '/builds/slave/test', 09:20:22 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:20:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:22 INFO - 'branch': 'Autoland-Non-PGO', 09:20:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:22 INFO - 'config_files': ('talos/linux_config.py',), 09:20:22 INFO - 'default_actions': ('clobber', 09:20:22 INFO - 'read-buildbot-config', 09:20:22 INFO - 'download-and-extract', 09:20:22 INFO - 'populate-webroot', 09:20:22 INFO - 'create-virtualenv', 09:20:22 INFO - 'install', 09:20:22 INFO - 'run-tests'), 09:20:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:22 INFO - 'download_minidump_stackwalk': True, 09:20:22 INFO - 'download_symbols': 'ondemand', 09:20:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:22 INFO - 'installer_path': 'installer.exe', 09:20:22 INFO - 'log_level': 'info', 09:20:22 INFO - 'log_name': 'talos', 09:20:22 INFO - 'log_to_console': True, 09:20:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:20:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:20:22 INFO - 'opt_config_files': (), 09:20:22 INFO - 'pip_index': False, 09:20:22 INFO - 'sps_profile': False, 09:20:22 INFO - 'sps_profile_interval': 0, 09:20:22 INFO - 'suite': 'dromaeojs-e10s', 09:20:22 INFO - 'system_bits': '32', 09:20:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:22 INFO - 'title': 'talos-linux64-ix-038', 09:20:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:22 INFO - 'use_talos_json': True, 09:20:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:22 INFO - 'work_dir': 'build'} 09:20:22 INFO - [mozharness: 2016-07-25 16:20:22.827668Z] Running clobber step. 09:20:22 INFO - Running pre-action listener: _resource_record_pre_action 09:20:22 INFO - Running main action method: clobber 09:20:22 INFO - rmtree: /builds/slave/test/build 09:20:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:23 INFO - Running post-action listener: _resource_record_post_action 09:20:23 INFO - [mozharness: 2016-07-25 16:20:23.309623Z] Finished clobber step (success) 09:20:23 INFO - [mozharness: 2016-07-25 16:20:23.309726Z] Running read-buildbot-config step. 09:20:23 INFO - Running pre-action listener: _resource_record_pre_action 09:20:23 INFO - Running main action method: read_buildbot_config 09:20:23 INFO - Using buildbot properties: 09:20:23 INFO - { 09:20:23 INFO - "project": "", 09:20:23 INFO - "product": "firefox", 09:20:23 INFO - "script_repo_revision": "production", 09:20:23 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:20:23 INFO - "repository": "", 09:20:23 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 09:20:23 INFO - "buildid": "20160725055525", 09:20:23 INFO - "pgo_build": "False", 09:20:23 INFO - "basedir": "/builds/slave/test", 09:20:23 INFO - "buildnumber": 137, 09:20:23 INFO - "slavename": "talos-linux64-ix-038", 09:20:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:20:23 INFO - "platform": "ubuntu64_hw", 09:20:23 INFO - "scheduler": "tests-autoland-linux64-talos", 09:20:23 INFO - "branch": "autoland", 09:20:23 INFO - "repo_path": "integration/autoland", 09:20:23 INFO - "revision": "bc767d7a30ddb701a9b2bd62670fdbe14780f81f", 09:20:23 INFO - "stage_platform": "linux64", 09:20:23 INFO - "builduid": "1a746a1fe5174b1eafb83b4820e16575", 09:20:23 INFO - "slavebuilddir": "test" 09:20:23 INFO - } 09:20:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:20:23 INFO - Running post-action listener: _resource_record_post_action 09:20:23 INFO - [mozharness: 2016-07-25 16:20:23.312179Z] Finished read-buildbot-config step (success) 09:20:23 INFO - [mozharness: 2016-07-25 16:20:23.312268Z] Running download-and-extract step. 09:20:23 INFO - Running pre-action listener: _resource_record_pre_action 09:20:23 INFO - Running main action method: download_and_extract 09:20:23 INFO - mkdir: /builds/slave/test/build/tests 09:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:23 INFO - https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:20:25 INFO - Downloaded 1361 bytes. 09:20:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:20:25 INFO - Using the following test package requirements: 09:20:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:20:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:20:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'jsshell-linux-x86_64.zip'], 09:20:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:20:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:20:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:20:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:20:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:20:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:25 INFO - https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:20:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:20:27 INFO - Downloaded 22737746 bytes. 09:20:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:20:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:20:28 INFO - Return code: 0 09:20:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:20: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')]} 09:20:28 INFO - https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:20:29 INFO - Downloaded 22737746 bytes. 09:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:20:31 INFO - Return code: 0 09:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:31 INFO - https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:20:32 INFO - Downloaded 14413725 bytes. 09:20:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:20:32 INFO - Return code: 0 09:20:32 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')]} 09:20:32 INFO - https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:20:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:20:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:20:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:20:35 INFO - Downloaded 57162326 bytes. 09:20:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:20:35 INFO - mkdir: /builds/slave/test/properties 09:20:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:35 INFO - Contents: 09:20:35 INFO - build_url:https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:20:36 INFO - Running post-action listener: _resource_record_post_action 09:20:36 INFO - Running post-action listener: set_extra_try_arguments 09:20:36 INFO - [mozharness: 2016-07-25 16:20:36.102461Z] Finished download-and-extract step (success) 09:20:36 INFO - [mozharness: 2016-07-25 16:20:36.102695Z] Running populate-webroot step. 09:20:36 INFO - Running pre-action listener: _resource_record_pre_action 09:20:36 INFO - Running main action method: populate_webroot 09:20:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:36 INFO - '--tppagecycles', 09:20:36 INFO - '7'], 09:20:36 INFO - 'tests': ['tsvgm']}}, 09:20:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:20:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['damp', 'tps']}, 09:20:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'tests': ['damp', 'tps']}, 09:20:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['dromaeo_dom']}, 09:20:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['basic_compositor_video']}, 09:20:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:20:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['a11yr', 09:20:36 INFO - 'ts_paint', 09:20:36 INFO - 'tpaint', 09:20:36 INFO - 'sessionrestore', 09:20:36 INFO - 'sessionrestore_no_auto_restore', 09:20:36 INFO - 'tabpaint']}, 09:20:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['tsvgx', 09:20:36 INFO - 'tsvgr_opacity', 09:20:36 INFO - 'tart', 09:20:36 INFO - 'tscrollx', 09:20:36 INFO - 'cart']}, 09:20:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:36 INFO - 'tsvgr_opacity', 09:20:36 INFO - 'tart', 09:20:36 INFO - 'tscrollx', 09:20:36 INFO - 'cart']}, 09:20:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'talos_options': ['--disable-e10s'], 09:20:36 INFO - 'tests': ['tp5o']}, 09:20:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'tests': ['tp5o']}, 09:20:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'talos_options': ['--disable-e10s', 09:20:36 INFO - '--xperf_path', 09:20:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:36 INFO - 'tests': ['tp5n']}, 09:20:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:36 INFO - 'talos_options': ['--xperf_path', 09:20:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:36 INFO - 'tests': ['tp5n']}}, 09:20:36 INFO - 'talos.zip': {'path': '', 09:20:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:36 INFO - Running post-action listener: _resource_record_post_action 09:20:36 INFO - [mozharness: 2016-07-25 16:20:36.120788Z] Finished populate-webroot step (success) 09:20:36 INFO - [mozharness: 2016-07-25 16:20:36.120877Z] Running create-virtualenv step. 09:20:36 INFO - Running pre-action listener: _resource_record_pre_action 09:20:36 INFO - Running main action method: create_virtualenv 09:20:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:36 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 09:20:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:36 INFO - Using real prefix '/usr' 09:20:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:38 INFO - Installing pip.................done. 09:20:38 INFO - Return code: 0 09:20:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:20:38 INFO - Using env: {'DISPLAY': ':0', 09:20:38 INFO - 'HOME': '/home/cltbld', 09:20:38 INFO - 'LANG': 'en_US.UTF-8', 09:20:38 INFO - 'LANGUAGE': 'en_US:en', 09:20:38 INFO - 'LOGNAME': 'cltbld', 09:20:38 INFO - 'MAIL': '/var/mail/cltbld', 09:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:38 INFO - 'MOZ_NO_REMOTE': '1', 09:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:38 INFO - 'NO_EM_RESTART': '1', 09:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:38 INFO - 'PWD': '/builds/slave/test', 09:20:38 INFO - 'SHELL': '/bin/bash', 09:20:38 INFO - 'SHLVL': '1', 09:20:38 INFO - 'TERM': 'linux', 09:20:38 INFO - 'TMOUT': '86400', 09:20:38 INFO - 'USER': 'cltbld', 09:20:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:38 INFO - '_': '/tools/buildbot/bin/python'} 09:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:38 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 09:20:38 INFO - Cleaning up... 09:20:38 INFO - Return code: 0 09:20:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:20:38 INFO - Using env: {'DISPLAY': ':0', 09:20:38 INFO - 'HOME': '/home/cltbld', 09:20:38 INFO - 'LANG': 'en_US.UTF-8', 09:20:38 INFO - 'LANGUAGE': 'en_US:en', 09:20:38 INFO - 'LOGNAME': 'cltbld', 09:20:38 INFO - 'MAIL': '/var/mail/cltbld', 09:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:38 INFO - 'MOZ_NO_REMOTE': '1', 09:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:38 INFO - 'NO_EM_RESTART': '1', 09:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:38 INFO - 'PWD': '/builds/slave/test', 09:20:38 INFO - 'SHELL': '/bin/bash', 09:20:38 INFO - 'SHLVL': '1', 09:20:38 INFO - 'TERM': 'linux', 09:20:38 INFO - 'TMOUT': '86400', 09:20:38 INFO - 'USER': 'cltbld', 09:20:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:38 INFO - '_': '/tools/buildbot/bin/python'} 09:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:39 INFO - Downloading/unpacking psutil>=3.1.1 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:41 INFO - Installing collected packages: psutil 09:20:41 INFO - Running setup.py install for psutil 09:20:41 INFO - building 'psutil._psutil_linux' extension 09:20:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:20:41 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 09:20:41 INFO - building 'psutil._psutil_posix' extension 09:20:41 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 09:20:41 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 09:20:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:41 INFO - Successfully installed psutil 09:20:41 INFO - Cleaning up... 09:20:41 INFO - Return code: 0 09:20:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:20: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 mozsystemmonitor==0.3 09:20:41 INFO - Using env: {'DISPLAY': ':0', 09:20:41 INFO - 'HOME': '/home/cltbld', 09:20:41 INFO - 'LANG': 'en_US.UTF-8', 09:20:41 INFO - 'LANGUAGE': 'en_US:en', 09:20:41 INFO - 'LOGNAME': 'cltbld', 09:20:41 INFO - 'MAIL': '/var/mail/cltbld', 09:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:41 INFO - 'MOZ_NO_REMOTE': '1', 09:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:41 INFO - 'NO_EM_RESTART': '1', 09:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:41 INFO - 'PWD': '/builds/slave/test', 09:20:41 INFO - 'SHELL': '/bin/bash', 09:20:41 INFO - 'SHLVL': '1', 09:20:41 INFO - 'TERM': 'linux', 09:20:41 INFO - 'TMOUT': '86400', 09:20:41 INFO - 'USER': 'cltbld', 09:20:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:41 INFO - '_': '/tools/buildbot/bin/python'} 09:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20:41 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 09:20:41 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 09:20:41 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 09:20:41 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 09:20:41 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 09:20:41 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 09:20:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:20:43 INFO - Installing collected packages: mozsystemmonitor 09:20:43 INFO - Running setup.py install for mozsystemmonitor 09:20:43 INFO - Successfully installed mozsystemmonitor 09:20:43 INFO - Cleaning up... 09:20:44 INFO - Return code: 0 09:20:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:44 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:44 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 09:20:44 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 09:20:44 INFO - Using env: {'DISPLAY': ':0', 09:20:44 INFO - 'HOME': '/home/cltbld', 09:20:44 INFO - 'LANG': 'en_US.UTF-8', 09:20:44 INFO - 'LANGUAGE': 'en_US:en', 09:20:44 INFO - 'LOGNAME': 'cltbld', 09:20:44 INFO - 'MAIL': '/var/mail/cltbld', 09:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:44 INFO - 'MOZ_NO_REMOTE': '1', 09:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:44 INFO - 'NO_EM_RESTART': '1', 09:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:44 INFO - 'PWD': '/builds/slave/test', 09:20:44 INFO - 'SHELL': '/bin/bash', 09:20:44 INFO - 'SHLVL': '1', 09:20:44 INFO - 'TERM': 'linux', 09:20:44 INFO - 'TMOUT': '86400', 09:20:44 INFO - 'USER': 'cltbld', 09:20:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:44 INFO - '_': '/tools/buildbot/bin/python'} 09:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:44 INFO - Downloading/unpacking jsonschema==2.5.1 09:20:44 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 09:20:44 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 09:20:44 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 09:20:44 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 09:20:44 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 09:20:44 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 09:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:46 INFO - warning: no files found matching '*.txt' 09:20:46 INFO - no previously-included directories found matching 'build' 09:20:46 INFO - no previously-included directories found matching 'dist' 09:20:46 INFO - no previously-included directories found matching '.git*' 09:20:46 INFO - Installing collected packages: jsonschema, functools32 09:20:46 INFO - Running setup.py install for functools32 09:20:46 INFO - warning: no files found matching '*.txt' 09:20:46 INFO - no previously-included directories found matching 'build' 09:20:46 INFO - no previously-included directories found matching 'dist' 09:20:46 INFO - no previously-included directories found matching '.git*' 09:20:46 INFO - Successfully installed jsonschema functools32 09:20:46 INFO - Cleaning up... 09:20:46 INFO - Return code: 0 09:20:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:20:46 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')]} 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 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')]} 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:46 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 09:20:46 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 09:20:46 INFO - Using env: {'DISPLAY': ':0', 09:20:46 INFO - 'HOME': '/home/cltbld', 09:20:46 INFO - 'LANG': 'en_US.UTF-8', 09:20:46 INFO - 'LANGUAGE': 'en_US:en', 09:20:46 INFO - 'LOGNAME': 'cltbld', 09:20:46 INFO - 'MAIL': '/var/mail/cltbld', 09:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:46 INFO - 'MOZ_NO_REMOTE': '1', 09:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:46 INFO - 'NO_EM_RESTART': '1', 09:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:46 INFO - 'PWD': '/builds/slave/test', 09:20:46 INFO - 'SHELL': '/bin/bash', 09:20:46 INFO - 'SHLVL': '1', 09:20:46 INFO - 'TERM': 'linux', 09:20:46 INFO - 'TMOUT': '86400', 09:20:46 INFO - 'USER': 'cltbld', 09:20:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:46 INFO - '_': '/tools/buildbot/bin/python'} 09:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:20:46 INFO - Cleaning up... 09:20:46 INFO - Return code: 0 09:20:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20:46 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')]} 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 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')]} 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:46 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 09:20:46 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 09:20:46 INFO - Using env: {'DISPLAY': ':0', 09:20:46 INFO - 'HOME': '/home/cltbld', 09:20:46 INFO - 'LANG': 'en_US.UTF-8', 09:20:46 INFO - 'LANGUAGE': 'en_US:en', 09:20:46 INFO - 'LOGNAME': 'cltbld', 09:20:46 INFO - 'MAIL': '/var/mail/cltbld', 09:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:46 INFO - 'MOZ_NO_REMOTE': '1', 09:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:46 INFO - 'NO_EM_RESTART': '1', 09:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:46 INFO - 'PWD': '/builds/slave/test', 09:20:46 INFO - 'SHELL': '/bin/bash', 09:20:46 INFO - 'SHLVL': '1', 09:20:46 INFO - 'TERM': 'linux', 09:20:46 INFO - 'TMOUT': '86400', 09:20:46 INFO - 'USER': 'cltbld', 09:20:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:46 INFO - '_': '/tools/buildbot/bin/python'} 09:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 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 09:20:49 INFO - Downloading docopt-0.6.1.tar.gz 09:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:49 INFO - Running setup.py install for blobuploader 09:20:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:50 INFO - Running setup.py install for requests 09:20:50 INFO - Running setup.py install for docopt 09:20:50 INFO - Successfully installed blobuploader requests docopt 09:20:50 INFO - Cleaning up... 09:20:50 INFO - Return code: 0 09:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:50 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')]} 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:50 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')]} 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:50 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:50 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 09:20:50 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 09:20:50 INFO - Using env: {'DISPLAY': ':0', 09:20:50 INFO - 'HOME': '/home/cltbld', 09:20:50 INFO - 'LANG': 'en_US.UTF-8', 09:20:50 INFO - 'LANGUAGE': 'en_US:en', 09:20:50 INFO - 'LOGNAME': 'cltbld', 09:20:50 INFO - 'MAIL': '/var/mail/cltbld', 09:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:50 INFO - 'MOZ_NO_REMOTE': '1', 09:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:50 INFO - 'NO_EM_RESTART': '1', 09:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:50 INFO - 'PWD': '/builds/slave/test', 09:20:50 INFO - 'SHELL': '/bin/bash', 09:20:50 INFO - 'SHLVL': '1', 09:20:50 INFO - 'TERM': 'linux', 09:20:50 INFO - 'TMOUT': '86400', 09:20:50 INFO - 'USER': 'cltbld', 09:20:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:50 INFO - '_': '/tools/buildbot/bin/python'} 09:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:50 INFO - Running setup.py (path:/tmp/pip-BeQvvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:50 INFO - Running setup.py (path:/tmp/pip-g0syWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:50 INFO - Running setup.py (path:/tmp/pip-9eGsD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:50 INFO - Running setup.py (path:/tmp/pip-6daVC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:51 INFO - Running setup.py (path:/tmp/pip-aH5spJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:51 INFO - Running setup.py (path:/tmp/pip-VUnXY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:51 INFO - Running setup.py (path:/tmp/pip-Jlvh8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:51 INFO - Running setup.py (path:/tmp/pip-HS59uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:51 INFO - Running setup.py (path:/tmp/pip-rnwgES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:51 INFO - Running setup.py (path:/tmp/pip-IrkAKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:51 INFO - Running setup.py (path:/tmp/pip-e0qwlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:51 INFO - Running setup.py (path:/tmp/pip-WXkvBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:51 INFO - Running setup.py (path:/tmp/pip-Qsdkp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:51 INFO - Running setup.py (path:/tmp/pip-7ZcdDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:51 INFO - Running setup.py (path:/tmp/pip-taA76l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:51 INFO - Running setup.py (path:/tmp/pip-Ao9kzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:51 INFO - Running setup.py (path:/tmp/pip-1n13Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:51 INFO - Running setup.py install for manifestparser 09:20:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Running setup.py install for mozcrash 09:20:52 INFO - Running setup.py install for mozdebug 09:20:52 INFO - Running setup.py install for mozdevice 09:20:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Running setup.py install for mozfile 09:20:52 INFO - Running setup.py install for mozhttpd 09:20:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Running setup.py install for mozinfo 09:20:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Running setup.py install for mozInstall 09:20:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:52 INFO - Running setup.py install for mozleak 09:20:52 INFO - Running setup.py install for mozlog 09:20:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Running setup.py install for moznetwork 09:20:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Running setup.py install for mozprocess 09:20:53 INFO - Running setup.py install for mozprofile 09:20:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Running setup.py install for mozrunner 09:20:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Running setup.py install for mozscreenshot 09:20:53 INFO - Running setup.py install for moztest 09:20:53 INFO - Running setup.py install for mozversion 09:20:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:53 INFO - Cleaning up... 09:20:53 INFO - Return code: 0 09:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:53 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')]} 09:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:53 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')]} 09:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:53 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:53 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 09:20:53 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 09:20:53 INFO - Using env: {'DISPLAY': ':0', 09:20:53 INFO - 'HOME': '/home/cltbld', 09:20:53 INFO - 'LANG': 'en_US.UTF-8', 09:20:53 INFO - 'LANGUAGE': 'en_US:en', 09:20:53 INFO - 'LOGNAME': 'cltbld', 09:20:53 INFO - 'MAIL': '/var/mail/cltbld', 09:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:53 INFO - 'MOZ_NO_REMOTE': '1', 09:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:53 INFO - 'NO_EM_RESTART': '1', 09:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:53 INFO - 'PWD': '/builds/slave/test', 09:20:53 INFO - 'SHELL': '/bin/bash', 09:20:53 INFO - 'SHLVL': '1', 09:20:53 INFO - 'TERM': 'linux', 09:20:53 INFO - 'TMOUT': '86400', 09:20:53 INFO - 'USER': 'cltbld', 09:20:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:53 INFO - '_': '/tools/buildbot/bin/python'} 09:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:53 INFO - Running setup.py (path:/tmp/pip-1HC4UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:54 INFO - Running setup.py (path:/tmp/pip-6zDAk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:54 INFO - Running setup.py (path:/tmp/pip-g6tgOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:54 INFO - Running setup.py (path:/tmp/pip-GGwOcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:54 INFO - Running setup.py (path:/tmp/pip-L3INrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:54 INFO - Running setup.py (path:/tmp/pip-wwJqIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:54 INFO - Running setup.py (path:/tmp/pip-xZt09S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:54 INFO - Running setup.py (path:/tmp/pip-mE2xR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:54 INFO - Running setup.py (path:/tmp/pip-8WuKFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:54 INFO - Running setup.py (path:/tmp/pip-fTcKRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:54 INFO - Running setup.py (path:/tmp/pip-_yW_Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:54 INFO - Running setup.py (path:/tmp/pip-qfvw6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:54 INFO - Running setup.py (path:/tmp/pip-2XCRQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:54 INFO - Running setup.py (path:/tmp/pip-nvfiqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:54 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)) 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:54 INFO - Running setup.py (path:/tmp/pip-mnokn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:55 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)) 09:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:55 INFO - Running setup.py (path:/tmp/pip-W87BKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:55 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)) 09:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:55 INFO - Running setup.py (path:/tmp/pip-P_jUQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:55 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)) 09:20:55 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)) 09:20:55 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)) 09:20:55 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)) 09:20:55 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)) 09:20:55 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)) 09:20:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:55 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 09:20:55 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 09:20:55 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 09:20:55 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 09:20:55 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 09:20:55 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 09:20:57 INFO - Downloading blessings-1.6.tar.gz 09:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:57 INFO - Installing collected packages: blessings 09:20:57 INFO - Running setup.py install for blessings 09:20:57 INFO - Successfully installed blessings 09:20:57 INFO - Cleaning up... 09:20:57 INFO - Return code: 0 09:20:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:57 INFO - Reading from file tmpfile_stdout 09:20:57 INFO - Current package versions: 09:20:57 INFO - argparse == 1.2.1 09:20:57 INFO - blessings == 1.6 09:20:57 INFO - blobuploader == 1.2.4 09:20:57 INFO - docopt == 0.6.1 09:20:57 INFO - functools32 == 3.2.3-2 09:20:57 INFO - jsonschema == 2.5.1 09:20:57 INFO - manifestparser == 1.1 09:20:57 INFO - mozInstall == 1.12 09:20:57 INFO - mozcrash == 0.17 09:20:57 INFO - mozdebug == 0.1 09:20:57 INFO - mozdevice == 0.48 09:20:57 INFO - mozfile == 1.2 09:20:57 INFO - mozhttpd == 0.7 09:20:57 INFO - mozinfo == 0.9 09:20:57 INFO - mozleak == 0.1 09:20:57 INFO - mozlog == 3.3 09:20:57 INFO - moznetwork == 0.27 09:20:57 INFO - mozprocess == 0.23 09:20:57 INFO - mozprofile == 0.28 09:20:57 INFO - mozrunner == 6.12 09:20:57 INFO - mozscreenshot == 0.1 09:20:57 INFO - mozsystemmonitor == 0.3 09:20:57 INFO - moztest == 0.7 09:20:57 INFO - mozversion == 1.4 09:20:57 INFO - psutil == 3.1.1 09:20:57 INFO - requests == 1.2.3 09:20:57 INFO - wsgiref == 0.1.2 09:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:57 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')]} 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 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')]} 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:57 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 09:20:57 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 09:20:57 INFO - Using env: {'DISPLAY': ':0', 09:20:57 INFO - 'HOME': '/home/cltbld', 09:20:57 INFO - 'LANG': 'en_US.UTF-8', 09:20:57 INFO - 'LANGUAGE': 'en_US:en', 09:20:57 INFO - 'LOGNAME': 'cltbld', 09:20:57 INFO - 'MAIL': '/var/mail/cltbld', 09:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:57 INFO - 'MOZ_NO_REMOTE': '1', 09:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:57 INFO - 'NO_EM_RESTART': '1', 09:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:57 INFO - 'PWD': '/builds/slave/test', 09:20:57 INFO - 'SHELL': '/bin/bash', 09:20:57 INFO - 'SHLVL': '1', 09:20:57 INFO - 'TERM': 'linux', 09:20:57 INFO - 'TMOUT': '86400', 09:20:57 INFO - 'USER': 'cltbld', 09:20:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:57 INFO - '_': '/tools/buildbot/bin/python'} 09:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 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)) 09:20:57 INFO - Cleaning up... 09:20:57 INFO - Return code: 0 09:20:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:57 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')]} 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 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')]} 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 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 0x15a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', '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 09:20:57 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 09:20:57 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 09:20:57 INFO - Using env: {'DISPLAY': ':0', 09:20:57 INFO - 'HOME': '/home/cltbld', 09:20:57 INFO - 'LANG': 'en_US.UTF-8', 09:20:57 INFO - 'LANGUAGE': 'en_US:en', 09:20:57 INFO - 'LOGNAME': 'cltbld', 09:20:57 INFO - 'MAIL': '/var/mail/cltbld', 09:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:57 INFO - 'MOZ_NO_REMOTE': '1', 09:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:57 INFO - 'NO_EM_RESTART': '1', 09:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:57 INFO - 'PWD': '/builds/slave/test', 09:20:57 INFO - 'SHELL': '/bin/bash', 09:20:57 INFO - 'SHLVL': '1', 09:20:57 INFO - 'TERM': 'linux', 09:20:57 INFO - 'TMOUT': '86400', 09:20:57 INFO - 'USER': 'cltbld', 09:20:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:57 INFO - '_': '/tools/buildbot/bin/python'} 09:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:58 INFO - Cleaning up... 09:20:58 INFO - Return code: 0 09:20:58 INFO - Running post-action listener: _resource_record_post_action 09:20:58 INFO - Running post-action listener: _start_resource_monitoring 09:20:58 INFO - Starting resource monitoring. 09:20:58 INFO - [mozharness: 2016-07-25 16:20:58.145166Z] Finished create-virtualenv step (success) 09:20:58 INFO - [mozharness: 2016-07-25 16:20:58.145607Z] Running install step. 09:20:58 INFO - Running pre-action listener: _resource_record_pre_action 09:20:58 INFO - Running main action method: install 09:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:58 INFO - Reading from file tmpfile_stdout 09:20:58 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:58 INFO - Reading from file tmpfile_stdout 09:20:58 INFO - Output received: 09:20:58 INFO - Usage: mozinstall [options] installer 09:20:58 INFO - Options: 09:20:58 INFO - -h, --help show this help message and exit 09:20:58 INFO - -d DEST, --destination=DEST 09:20:58 INFO - Directory to install application into. [default: 09:20:58 INFO - "/builds/slave/test"] 09:20:58 INFO - --app=APP Application being installed. [default: firefox] 09:20:58 INFO - mkdir: /builds/slave/test/build/application 09:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:21:15 INFO - Reading from file tmpfile_stdout 09:21:15 INFO - Output received: 09:21:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:21:15 INFO - Running post-action listener: _resource_record_post_action 09:21:15 INFO - [mozharness: 2016-07-25 16:21:15.204288Z] Finished install step (success) 09:21:15 INFO - [mozharness: 2016-07-25 16:21:15.204567Z] Running run-tests step. 09:21:15 INFO - Running pre-action listener: _resource_record_pre_action 09:21:15 INFO - Running main action method: run_tests 09:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:15 INFO - Python 2.7.3 09:21:15 INFO - Return code: 0 09:21:15 INFO - grabbing minidump binary from tooltool 09:21:15 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')]} 09:21:15 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 0x185e570>, '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 0x185f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:15 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 09:21:15 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 09:21:15 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 09:21:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:15 INFO - Return code: 0 09:21:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:21:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:21:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:15 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/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:21:15 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/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:21:15 INFO - Using env: {'DISPLAY': ':0', 09:21:15 INFO - 'HOME': '/home/cltbld', 09:21:15 INFO - 'LANG': 'en_US.UTF-8', 09:21:15 INFO - 'LANGUAGE': 'en_US:en', 09:21:15 INFO - 'LOGNAME': 'cltbld', 09:21:15 INFO - 'MAIL': '/var/mail/cltbld', 09:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:15 INFO - 'MOZ_NO_REMOTE': '1', 09:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:15 INFO - 'NO_EM_RESTART': '1', 09:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:15 INFO - 'PWD': '/builds/slave/test', 09:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:15 INFO - 'SHELL': '/bin/bash', 09:21:15 INFO - 'SHLVL': '1', 09:21:15 INFO - 'TERM': 'linux', 09:21:15 INFO - 'TMOUT': '86400', 09:21:15 INFO - 'USER': 'cltbld', 09:21:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009', 09:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:15 INFO - '_': '/tools/buildbot/bin/python'} 09:21:15 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/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:21:15 INFO - mozversion application_buildid: 20160725055525 09:21:15 INFO - mozversion application_changeset: bc767d7a30ddb701a9b2bd62670fdbe14780f81f 09:21:15 INFO - mozversion application_display_name: Nightly 09:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:15 INFO - mozversion application_name: Firefox 09:21:15 INFO - mozversion application_remotingname: firefox 09:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:21:15 INFO - mozversion application_vendor: Mozilla 09:21:15 INFO - mozversion application_version: 50.0a1 09:21:15 INFO - mozversion platform_buildid: 20160725055525 09:21:15 INFO - mozversion platform_changeset: bc767d7a30ddb701a9b2bd62670fdbe14780f81f 09:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:21:15 INFO - mozversion platform_version: 50.0a1 09:21:15 INFO - using testdate: 1469463675 09:21:15 INFO - actual date: 1469463675 09:21:15 INFO - starting webserver on 'localhost:40117' 09:21:15 INFO - SUITE-START | Running 2 tests 09:21:15 INFO - TEST-START | dromaeo_css 09:21:15 INFO - operating with platform_type : linux_ 09:21:15 INFO - Initialising browser for dromaeo_css test... 09:21:15 INFO - TEST-INFO | started process 21329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLRoEdJ/profile http://localhost:40117/getInfo.html) 09:21:19 INFO - PROCESS | 21329 | JavaScript error: , line 0: uncaught exception: undefined 09:21:21 INFO - PROCESS | 21329 | __metrics Screen width/height:1600/1200 09:21:21 INFO - PROCESS | 21329 | colorDepth:24 09:21:21 INFO - PROCESS | 21329 | Browser inner width/height: 1024/697 09:21:21 INFO - PROCESS | 21329 | __metrics 09:21:22 ERROR - PROCESS | 21329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:21:23 INFO - TEST-INFO | 21329: exit 0 09:21:23 INFO - Browser initialized. 09:21:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:23 INFO - TEST-INFO | started process 21444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLRoEdJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:35 INFO - PROCESS | 21444 | RSS: Main: 165572608 09:21:35 INFO - PROCESS | 21444 | 09:22:24 INFO - PROCESS | 21444 | 1469463744660 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] 09:24:37 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40117/tests/dromaeo/cssquery-ext.html) 09:24:38 INFO - PROCESS | 21444 | RSS: Main: 168419328 09:24:38 INFO - PROCESS | 21444 | 09:27:40 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-ext.html (next: http://localhost:40117/tests/dromaeo/cssquery-jquery.html) 09:27:41 INFO - PROCESS | 21444 | RSS: Main: 167215104 09:27:41 INFO - PROCESS | 21444 | 09:30:43 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40117/tests/dromaeo/cssquery-mootools.html) 09:30:44 INFO - PROCESS | 21444 | RSS: Main: 171032576 09:30:44 INFO - PROCESS | 21444 | 09:33:45 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40117/tests/dromaeo/cssquery-prototype.html) 09:33:46 INFO - PROCESS | 21444 | RSS: Main: 165031936 09:33:46 INFO - PROCESS | 21444 | 09:36:49 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40117/tests/dromaeo/cssquery-yui.html) 09:36:50 INFO - PROCESS | 21444 | RSS: Main: 167395328 09:36:50 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | Cycle 1(1): loaded http://localhost:40117/tests/dromaeo/cssquery-yui.html (next: http://localhost:40117/tests/dromaeo/cssquery-dojo.html) 09:39:52 INFO - PROCESS | 21444 | RSS: Main: 170647552 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | __start_tp_report 09:39:52 INFO - PROCESS | 21444 | _x_x_mozilla_page_load 09:39:52 INFO - PROCESS | 21444 | _x_x_mozilla_page_load_details 09:39:52 INFO - PROCESS | 21444 | |i|pagename|runs| 09:39:52 INFO - PROCESS | 21444 | |0;dojo.html;2622.921312360629;2631.3947792007825;2658.747418995196;2666.106854203843;2677.143314139476;4757.977034937488;4846.660733748643;4866.197077482216;4893.877653058676;4912.21404575268;4809.495003024685;4845.345878306428;4865.756712164395;4881.389826271716;4884.951150488494;4418.801153948064;4449.710768800018;4461.4869290031575;4463.955360446403;4544.681872268942;4459.353393757903;4467.396901418299;4478.171538265415;4489.416375871132;4552.567506086933;4556.2937744649635;4578.587927086562;4586.564276393738;4592.793324300398;4609.953900460986;4345.891352716176;4379.5182529921685;4400.911981760379;4487.39420178275;4526.958799476139;4348.543402942709;4356.912861742779;4364.803583838735;4428.31361139024;4451.554844515555;4822.903541929142;4852.296417019513;4854.101991131652;4870.805167793284;4887.3890763654545;5155.587552995751;5161.225816127573;5165.974170129125;5188.610854185951;5232.816851410183;5255.1329030709885;5271.235670827747;5275.525202731773;5283.286756287929;5283.735813209362;4931.556159945622;4938.9012219755405;4939.975300123477;4943.06081844452;4952.2819191217795;5201;5288.762005709752;5315.123004704181;5328.307320048369;5424.050791111618;5101.183810590288;5132.923006154911;5137.12668846297;5137.280780690707;5152.175651895679;5202.401723801736;5213.244079608511;5231.346081739783;5236.3716354037;5259.684418934876;4952.281919121707;5043.899122017539;5048.873778155502;5079.6698214615935;5108.029474399852;5093.694378337312;5107.668001579886;5131.589472842164;5136.8202112925865;5156.355455568054;4371.628411584988;4372.584604462634;4375.343698445258;4387.802548885308;4427.380166776654;3754.662080412776;3784.6026167252594;3816.5229346331707;3832.9233415331537;3854.0750219947013;4409.007973206003;4454.465464144323;4457.286834106528;4464.464264288306;4476.597106260387;5206.140986737221;5208.296879921238;5210.478952104835;5214;5221.817236396708;4443.933340999887;4449.532799056053;4465.37484752135;4475;4502.122086193161;4532;4598.839040633562;4600.470945841204;4625.283081122431;4638.628909687217;4859.684120532083;4860.1251774680895;4862.41651001882;4899.020195960751;4905.632077594266;5209.6874187548865;5210.947890521198;5214.217867319932;5214.739263036909;5216.139337009351;4762.738049407316;4831.396075490564;4847.030593881308;4874.0495603357;4878.853634390974;5088.898222035613;5094.159463688598;5122.769475373542;5128.076946149579;5179.792808287777;5194.97402512985;5196.142636464941;5197.896042079213;5207.557357624644;5265.552428043659;4905.583025442877;4958.206686930074;5003.649744517848;5024.246363045572;5067.366579177603;4993.575546078624;4995.050940321327;4996.550310471929;5007.974960125176;5038.622103342191;4801.087793319258;4881.267809828554;4900.975495122501;4947.727874966768;4985.925211121908;4924.72913989734;4999.375078115236;5075.670081444694;5076.314697515788;5088.745562721923;4974.054929563371;4985.551300382983;4991.925121123113;4997.20044792846;5005.374328208974 09:39:52 INFO - PROCESS | 21444 | |1;ext.html;564.5088772767692;565.9575531835113;566.4081035318093;572.0418299348593;577.9219805326281;26821.731782682167;27532.449351012994;38106;39328;39476.80261598688;38490.615093849054;38499.807500962525;38713;38871.22257554847;38931;7710.151883292833;7831;7834.0990786059765;7848.254415830515;7871.330936870373;7761.185075567068;7828.843423131534;7832.373410127205;7845.568493732842;7846.882296765553;7809.687612495493;7826.1391246962785;7890.487118337319;7900.249476299742;7910;7775.4945928515035;7799.259070388304;7823.317986632873;7873.96063019687;7890.092639346462;7672.386209103258;7739.57432341221;7740.845183096307;7755.108162561265;7806.882896756553;37766.43350349747;38037.42943855844;38052.809735951145;38130.61869381298;38174;2861.625600694695;2887.133859842039;2891.493988551995;2898.7246211609863;2915.6938521455154;28069.71930280712;28263.293417664518;28618.427631447463;29233.561496577568;29344.559831602543;3337.4826901830256;3353.480210567366;3426.400379933502;3436.914077148066;3445.689887910075;241659;242437.99999999822;242565;242582;243063;47671.523284767405;48455.515444845805;48484.27273590899;48534.51465485371;48539.75730121327;30813.845930770203;31689.366212675617;31933.680663193536;46426.303605445944;46965.76517117461;14268.500602478864;14703.264836758119;14744.926275368769;14773.852261477463;14798.334074966437;11107.333559986426;11220.382878941737;11242.887571124184;11304.321740695585;11309.71725706864;16579.751303730452;16613;16639.753633259596;16648.667026659397;16794.58013549671;6166.454288783967;6339.556231063873;6374.521910856704;6561.770338038145;6565.638889861008;814.3770015937812;939;1025.4411345816548;1030.7320096774743;1031.2265800649513;25537.361565961;27162.5925611116;27599.17202483929;27640.861795690893;27716.30709232245;933.9673111441067;946.3328353510758;946.9005754395827;1030.314840630987;1031.3193292426963;13820.792688109686;14699.853001470063;14781.852181478263;14799.112053276838;14979.251037448084;290563;295056;295760;295932;296114;44290.557094428645;44407.55592444034;44884.551154488036;44933.32600011003;44967.77516112399;1147.770445910821;1149.4195431307137;1175.3829239649253;1199.4782269712703;1211.594115971142;25024;26166.86916565405;26401.60397594076;26522.867385662947;26744.19767406981;39289.607103928596;39638;39672.20655586814;39673.603263966994;39774.40338394869;215016;215100;216042;216170;216270;22715;22933.655995159752;24375.634365484177;24499.877500612383;24882.626760598967;38201;38314.677424186404;38666;38958;39935.60064399435;33879.830600846835;33976.66023339735;34810.03213386746;35241.82379088088;35332.116697082776;34391.140221494665;35095.12262193466;35671.10822229465;35722;36248.63751362558;33957;34176.14559636029;35132;35432.82283588668;35574.466383004794;29173;30751.2312192197;31752.841235793672;31807;31941.8402907984;24379.634305485786;24395.14616988397;24608.384790379667;24718.505629887663;25001.624975625746 09:39:52 INFO - PROCESS | 21444 | |2;jquery.html;364.24964572979655;366.45398356448885;369.735639018102;381.7823840410965;385.4815273457199;15746.527604171864;16541.586460338483;17011.914940425282;17087.487375378758;17169.57076073099;16222.188890555484;16587.17064146794;16933.49199524016;17017.404390846325;17059.232334544944;4925.482824303459;5118.6416950813455;5119.0529751996;5122.795088196468;5123.462036486171;3764.661180493755;5071.31537242473;5678.375378708339;5911.645301281937;5936.792212272571;6005.549583781212;6010.429009244137;6018.127371531147;6024.668643224621;6035.366286539916;5932.614380065282;5935.703214839263;5978.222831031938;5980.491658209035;5983.042713165873;5128.615353848476;5175.197844334134;5278.683279003234;5283.365996080456;5293.04725149473;11447.656570302905;11905.345206013666;20581;20729.792702072937;20770.48073798152;1792.507060558344;1890.3194849854042;1978.0307649251906;1987.3541099142692;2364.6334818103223;9216.032316606726;9227.538623068887;9239.30705197113;9249.583768730423;9294.302927280414;1612.5887898585786;1632.6000129968234;1638.230031885012;1742.268247336122;1762.647470505904;60726.39273607296;65391.01913471349;66409.66795165994;69076;72309.63845180793;9501.714948551555;9505.239580833517;9574.234061275081;9888.269552828226;9894.703158905244;13390.866091339156;13399.799003014963;13480.39338229782;13485.865141348657;13486.39311230997;6849.554778939353;6981.720731170696;7051.647417629098;7246.782596522113;7251.093613298338;6746.392824645805;6776.86770910896;7031;7054.400375967997;7069.151701795818;4012.8996775080273;4035.6973227008093;4154.293770059097;4157.48031496063;4173.123644034726;1613.8305477924648;1686.468762339859;1763;1784.5627821183894;1830.249597664951;775.1783109903521;815.9020917489939;860.3934226370394;889.0709208876739;897.7486303834937;16590.52226104097;16706.164691765363;17155.57111072208;18244.63510729778;18570.25718971226;818.2635627934907;840.2227939156378;870.7779516223322;873.0876234335135;918.4626993209048;6463.806085817433;9751.609935602497;9755.268354873413;9779.41323520591;9921.702348929544;393581;396354;397160;419463;421170;47950.28074578884;75133;81941.59029204935;83611.58194209111;84138;921.4839689773614;944.9055094490496;955.2739917662626;1010.1817527802503;1014.7158795537114;15508.92245538765;15662.82528810321;16068.276927538054;16153;16421.67156656884;36449.45325820062;36817.63182368142;36907.8154609236;37350.25299493941;37368;45446.77276613596;47115.29327060028;52092;52128.73935630298;52890.2066469011;7402.629868506446;7523.887141692989;7551.697932082655;7636.274553917369;7638.159802421618;10478.161747060369;10691.358518488916;11202.15983801202;11465;11688.649340519798;9643;9721.70834874955;9784.51077446139;9950.601975921172;9961.35251208669;9919.40483570988;9945.900540994497;10113.949430253097;10120.291579589359;10232.130268927225;9584.9041509584;10082.949585252027;10095.545700443645;10346.120579750504;10376.844347334645;7337.816554586178;7343.522671026366;7410.481266311306;7414.8887766682465;7443.44174186949;8370.958145209235;9589.136977671764;9755.170810481188;9941.801163976825;9943.453110079015 09:39:52 INFO - PROCESS | 21444 | |3;mootools.html;1341.6712905338188;1385.1550554161963;1385.425048604829;1619.5951012246937;1626.9674606507876;6708.49686273529;7517.699292028312;7545.698172073117;8116.715914942978;8121.959390203041;7740.187280335554;7981.401394895377;8011.959940200305;8028.598570071487;8040.276375126237;2184.8142907852853;2215.936350551728;2220.3006053093304;2223.8665680059166;2228.4206106412366;2194.6378847490146;2234.575430668168;2239.8096161826265;2244.427670943907;2245.124401483423;2198.7801219877965;2209.6575030870163;2230.0856648774006;2230.0968107916237;2238.541099074686;2139.433050241679;2143.645091082549;2149.301477019967;2154.2675490333286;2162.6864104704887;2158.4280165756086;2160.9783902160934;2169.0889826273005;2173.4349069241953;2179.444241718352;7972.760817175494;8072.19278072194;8077.273045425881;8086.878696819553;8095.635696393676;4579.290210017452;4730.787114579818;4740.217864052427;4751.168545504523;4752.71483710975;2868.4549935512186;2881.178864023764;2939.103573410109;2974.940501189964;2993.9401211975855;864.8702694595798;932.2588542109039;939.567798812547;949.06991148674;950.6625148072472;11074.833877491845;11115.221934464671;11116;11129.554817807279;11144.33134011962;4143.606357396043;4334.306510958231;4428.158649856581;4474.217012022948;4483.103379324149;9371.109744574254;9392.90607093934;9400.106989835955;9403.482808445464;9414.529273536433;4804.231322988305;4823.734694591831;4834.226523756252;4841.3222148899185;4851.199552073939;3727.2918145552258;4246.532881383046;4340.804663790137;4365.825366985285;4389.846355377546;3637.5453068366455;3688.870889518854;3740.569834469071;3818.770873747584;3823.0824602095295;1216.8722284160035;1222.5232159457819;1223.7063104854772;1228.1403017887515;1238.9814152787715;756.8675481790775;791.4934441957153;791.9247671471201;793.0008189680929;794.3605397654943;5177.896442071213;5256.526912577886;5303.257543943774;5382.757775900094;5419.34967803866;411.9608637179523;420.9095044565433;426.1179358727405;428.57785081694504;429.3602532226959;3780.5085338905765;3803.2963901678277;3810.161764411825;3854.865079722252;3879.4568760373004;9149.542522873962;9488.33581649278;9563.282753793494;9568.282378821616;9882.308238423242;9750;9759.9024009759;9761.07269809367;9761.365511241747;9776.706698799047;7015.649217539102;7357.301056399633;7371.852562948711;7378.372838308804;7380.74167404149;5526.889462210814;5643;5699.116636921284;5730.885382292414;5793.333766616893;8666.869996949925;8688.087750786077;8875.33434992391;8917.777055573662;8935.776605584653;8948.328875334506;8990.730278091667;8990.910090899008;9065.365424420228;9079.45523268606;6079.209702738615;6477.190351206099;6660.733570657119;6835.897461537981;7028.718851245892;7614.923850761422;7667.731629392944;7685.5004424712215;7686.57723825195;7689.9615501922135;6538.738450461929;6601.207855057424;6642.136522252076;6678.866422671616;6787.423069039187;6687.899681504684;6703.932960670526;6722.697478613572;6887.345702158287;6912.688928998307;6345.365463453618;6362.204724409449;6420.454261387835;6424.582402143846;6438.066480360415;4684.578387945101;4767.165745994506;4802.27965805132;4810.975945120252;4875.268709693574;4675.485696573306;4679;4797.56821886032;4838.758062096811;4851.393575803025 09:39:52 INFO - PROCESS | 21444 | |4;prototype.html;283.71770088761673;298.8938926681028;301.8928280460438;304.8490996956505;306.69177476635986;4967.652264341497;4977.452480227172;5119.462456442071;5148.562372198363;5160.432352441228;4992.750362481879;5012.198048312271;5029.673071250366;5042.899142017158;5054.772535235914;3941.575930802557;3984.7808370539756;4005.038790690228;4007.519097708279;4008.13825027619;3902.414637804324;3983.50206224222;3990.4413382126527;3995.220931918277;4021.4168945502884;3923.136909879822;3929.5657085163853;3950.170464202521;3963.0686788604653;3974.642282194616;3914.9804250978705;3935.4096885467125;3949.940750888725;3953.723239373245;3961.623645753649;3254.544363789071;3377.7128944039787;3390.593128824557;3509.9649003509894;3522.18989632386;4853.0779151961015;4866.197077482211;4879.926801097987;4883.5604795568215;4940.777665005084;4474.239379305526;4479.843205487792;4485.596296333346;4495.056038231975;4499.6850220484575;5144.356955380577;5217.5565076968505;5245.606579506514;5279.762410691528;5323.920141197885;3722.8324725387424;3729.4219395993664;3736.7197460190596;3738.3084129436143;3746.906327341811;5517.227588137664;5577.386487486373;5577.9163312550345;5608.971955140199;5608.999999999959;3585.8744943926836;3831.904202394907;3833.15670552478;3834.5489059845804;3845.288621605012;3816.217675376541;3847.480590120354;3853.9807300963876;3857.6913846892744;3863.4204869269274;4424.778761061934;4425.291953287458;4439.511653718088;4449.354843547668;4456.665750068693;5269.815556455505;5273.3935597406025;5343.385510666323;5348.82325888304;5363.973180134074;1297.6366617347157;1343.603636927109;1345.6366780969083;1349.1432940083118;1352.452256835983;804.4931693033352;837.9539125348165;847.4449235750593;856.5674334461182;861.763015170833;4100.815463304159;4101.794910254475;4114.979425102915;4130.297849365615;4169.541350451448;4838.129496402864;4865.854024379274;4885.6335774817035;4886.511348865156;4902.656814022984;4175.498940127204;4192.392103145027;4197.811098500575;4205.3271476563605;4217.102303963229;2572.356910772307;2688.8790004449847;2899.623049003616;2906.287959449948;2917.854107294669;5098;5109.718965456936;5112.590992720573;5114.181730923035;5129.512696293846;5357.678539287577;5554.50009499147;5578.358488773762;5586.664800112007;5592.468715472024;5088.389393272831;5092.770825312796;5097.451274362818;5104.3155758600315;5113.693178409233;5464.33337831965;5466.72666366688;5473.589480789036;5477.794885125266;5483.725813709379;5111.233315002779;5349.170878513836;5350.5184533392185;5354.330708661418;5356.330458692663;5157.329547158845;5160.870978225575;5176.1200595899545;5183.352080989876;5192.3769147702515;3563.1448452371765;3647.3070116677745;3816.1032157442423;3873.65137137659;3884.0484081400236;5393.43368946255;5429.158480435539;5440.156775699615;5450.209719590716;5463.4263402342185;5280.894382112259;5283.181106928432;5298.841034768963;5305.840824775263;5344.144936810092;5037;5222.138347172826;5281.339832520935;5287.57699384056;5289.466054844052;5201.193814958688;5220.5382492902045;5229.457310093608;5243.737813109406;5256.947430525645;5324.520793128637;5337.6797392156595;5365.168398898021;5386.703731294817;5401.378841433286;5073.898522029613;5150.918307155539;5167.534921857051;5175.9741201293755;5183.300254465599 09:39:52 INFO - PROCESS | 21444 | |5;yui.html;562.0838034004572;598.8113744170587;620.5128973755603;730.8973407883535;735.4741359927652;12723.554675586356;13735.793963090562;13969.952253580985;13989.720205595895;14004.929975350109;12317.260964342124;12510.93744531276;12620.24278543288;12647.494100236003;12655.240685558872;768.8692922203211;790.3045320118288;791.0546896458734;791.9089304729944;792.4373694676786;637.4677144584277;768.1013214539003;785.9489133206351;787.0476723164949;788.763370988704;793.1949071692237;799.532273619933;803.5540275147291;810.7527204202715;820.3478234803316;820.9343252539783;822.9218224268685;825.6037102190952;825.7852958230843;827.5779352530222;603.5774957529746;604.8760004199129;608.4341562347015;611.0132136599404;612.0146564031905;14001.929990349983;14018.649533761636;14107.294635268196;14226.359813808403;14237.928810355985;13564.864351356458;13800.93099534496;13840.30798460073;13895.722085558233;14261.714765704732;10491.842622360595;10537.420441875694;10707.678769636923;10709.25035247533;10824.458777061116;3318.369509793156;3322.9335413291597;3351.3967485852536;3356.9160770980675;3371.696547310754;66071.339286607;68811.311886881;68916;70448.29551704468;71063.28936710619;9698;9907.653232136841;9966.152877005536;10080.243981701402;10085.546150423248;21158.365249042552;21169.470763230733;21170.470738231666;21207.561130469883;21218.681719774217;6668.866622667617;6721.462283017347;6806.76176333826;6907.620080895599;6962.756303529352;3407.9148021299666;3506.403911335079;3591.2278860045217;3592.3533763922746;3618.2763447310645;2913.6649285332032;2997.6252968378953;3006.128222815359;3030.9696903030685;3034.5903303053806;499.5079846351341;499.9550040496373;514.7091893080398;516.5531814980015;519.3923109961354;486.3312944701036;502.46989426155756;521.7495602111007;531.5136649965316;532.7416203141473;7535.321821036133;8026;8082.515049096955;8302.335813134934;8356.665733370719;475.74547617024723;562.5190462154881;570.3725901508391;609.3601718195877;618.4773866083152;3891.9416208756893;3942.7240093193773;4051.331530297527;4081.816318265626;4187.204431158131;86681.56659216664;88412.5579372099;91536.54231728798;91895.5405222983;93664;78374;78537.60731196307;80841.59579202184;81510;83143;71649.64175179091;72836;73524.26475735175;74028.25971740214;75743.86384204241;7832.960835196015;7975.2423519765525;8005.919940800751;8083.6766529338165;8141.186485135661;32966.67033329636;42635.57364426316;43197.78401107974;43800.780996094814;44826.55173448224;58129.4187058124;60111;64365.678171608844;64726;66929.66535167293;9518.476483793458;9729.4648794317;9769.071938165864;10031.498425078571;10197.337173083726;10624.946875265883;11227;11351.886481135414;11358.488868000795;11488.195826292414;10220.591176352862;10390.168786497214;10458.68623941283;10537.209709271681;10554;10796.244262901522;10843.728906777078;11211.71970700739;11463.885361146282;11563.768724625628;9889.2037361878;10269.691909242734;10274.126699230648;10480.371177729361;10488.10851077667;8870.911290887008;9464.621415143318;9474.478903660365;9479.478628675213;9491.66779162726;8975.102489750972;9552.092551207625;9640.276979226446;9669.129778319984;9673.467959262027 09:39:52 INFO - PROCESS | 21444 | __end_tp_report 09:39:52 INFO - PROCESS | 21444 | __start_cc_report 09:39:52 INFO - PROCESS | 21444 | _x_x_mozilla_cycle_collect,359 09:39:52 INFO - PROCESS | 21444 | __end_cc_report 09:39:52 INFO - PROCESS | 21444 | __startTimestamp1469464792828__endTimestamp 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | ------- Summary: start ------- 09:39:52 INFO - PROCESS | 21444 | Number of tests: 6 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#0] dojo.html Cycles:165 Average:4785.98 Median:4905.63 stddev:510.96 (10.4%) stddev-sans-first:483.53 09:39:52 INFO - PROCESS | 21444 | Values: 2622.9 2631.4 2658.7 2666.1 2677.1 4758.0 4846.7 4866.2 4893.9 4912.2 4809.5 4845.3 4865.8 4881.4 4885.0 4418.8 4449.7 4461.5 4464.0 4544.7 4459.4 4467.4 4478.2 4489.4 4552.6 4556.3 4578.6 4586.6 4592.8 4610.0 4345.9 4379.5 4400.9 4487.4 4527.0 4348.5 4356.9 4364.8 4428.3 4451.6 4822.9 4852.3 4854.1 4870.8 4887.4 5155.6 5161.2 5166.0 5188.6 5232.8 5255.1 5271.2 5275.5 5283.3 5283.7 4931.6 4938.9 4940.0 4943.1 4952.3 5201.0 5288.8 5315.1 5328.3 5424.1 5101.2 5132.9 5137.1 5137.3 5152.2 5202.4 5213.2 5231.3 5236.4 5259.7 4952.3 5043.9 5048.9 5079.7 5108.0 5093.7 5107.7 5131.6 5136.8 5156.4 4371.6 4372.6 4375.3 4387.8 4427.4 3754.7 3784.6 3816.5 3832.9 3854.1 4409.0 4454.5 4457.3 4464.5 4476.6 5206.1 5208.3 5210.5 5214.0 5221.8 4443.9 4449.5 4465.4 4475.0 4502.1 4532.0 4598.8 4600.5 4625.3 4638.6 4859.7 4860.1 4862.4 4899.0 4905.6 5209.7 5210.9 5214.2 5214.7 5216.1 4762.7 4831.4 4847.0 4874.0 4878.9 5088.9 5094.2 5122.8 5128.1 5179.8 5195.0 5196.1 5197.9 5207.6 5265.6 4905.6 4958.2 5003.6 5024.2 5067.4 4993.6 4995.1 4996.6 5008.0 5038.6 4801.1 4881.3 4901.0 4947.7 4985.9 4924.7 4999.4 5075.7 5076.3 5088.7 4974.1 4985.6 4991.9 4997.2 5005.4 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#1] ext.html Cycles:180 Average:40334.34 Median:18801.27 stddev:65989.10 (351.0%) stddev-sans-first:66106.65 09:39:52 INFO - PROCESS | 21444 | Values: 564.5 566.0 566.4 572.0 577.9 26821.7 27532.4 38106.0 39328.0 39476.8 38490.6 38499.8 38713.0 38871.2 38931.0 7710.2 7831.0 7834.1 7848.3 7871.3 7761.2 7828.8 7832.4 7845.6 7846.9 7809.7 7826.1 7890.5 7900.2 7910.0 7775.5 7799.3 7823.3 7874.0 7890.1 7672.4 7739.6 7740.8 7755.1 7806.9 37766.4 38037.4 38052.8 38130.6 38174.0 2861.6 2887.1 2891.5 2898.7 2915.7 28069.7 28263.3 28618.4 29233.6 29344.6 3337.5 3353.5 3426.4 3436.9 3445.7 241659.0 242438.0 242565.0 242582.0 243063.0 47671.5 48455.5 48484.3 48534.5 48539.8 30813.8 31689.4 31933.7 46426.3 46965.8 14268.5 14703.3 14744.9 14773.9 14798.3 11107.3 11220.4 11242.9 11304.3 11309.7 16579.8 16613.0 16639.8 16648.7 16794.6 6166.5 6339.6 6374.5 6561.8 6565.6 814.4 939.0 1025.4 1030.7 1031.2 25537.4 27162.6 27599.2 27640.9 27716.3 934.0 946.3 946.9 1030.3 1031.3 13820.8 14699.9 14781.9 14799.1 14979.3 290563.0 295056.0 295760.0 295932.0 296114.0 44290.6 44407.6 44884.6 44933.3 44967.8 1147.8 1149.4 1175.4 1199.5 1211.6 25024.0 26166.9 26401.6 26522.9 26744.2 39289.6 39638.0 39672.2 39673.6 39774.4 215016.0 215100.0 216042.0 216170.0 216270.0 22715.0 22933.7 24375.6 24499.9 24882.6 38201.0 38314.7 38666.0 38958.0 39935.6 33879.8 33976.7 34810.0 35241.8 35332.1 34391.1 35095.1 35671.1 35722.0 36248.6 33957.0 34176.1 35132.0 35432.8 35574.5 29173.0 30751.2 31752.8 31807.0 31941.8 24379.6 24395.1 24608.4 24718.5 25001.6 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#2] jquery.html Cycles:180 Average:24415.93 Median:28633.60 stddev:66858.60 (233.5%) stddev-sans-first:67021.77 09:39:52 INFO - PROCESS | 21444 | Values: 364.2 366.5 369.7 381.8 385.5 15746.5 16541.6 17011.9 17087.5 17169.6 16222.2 16587.2 16933.5 17017.4 17059.2 4925.5 5118.6 5119.1 5122.8 5123.5 3764.7 5071.3 5678.4 5911.6 5936.8 6005.5 6010.4 6018.1 6024.7 6035.4 5932.6 5935.7 5978.2 5980.5 5983.0 5128.6 5175.2 5278.7 5283.4 5293.0 11447.7 11905.3 20581.0 20729.8 20770.5 1792.5 1890.3 1978.0 1987.4 2364.6 9216.0 9227.5 9239.3 9249.6 9294.3 1612.6 1632.6 1638.2 1742.3 1762.6 60726.4 65391.0 66409.7 69076.0 72309.6 9501.7 9505.2 9574.2 9888.3 9894.7 13390.9 13399.8 13480.4 13485.9 13486.4 6849.6 6981.7 7051.6 7246.8 7251.1 6746.4 6776.9 7031.0 7054.4 7069.2 4012.9 4035.7 4154.3 4157.5 4173.1 1613.8 1686.5 1763.0 1784.6 1830.2 775.2 815.9 860.4 889.1 897.7 16590.5 16706.2 17155.6 18244.6 18570.3 818.3 840.2 870.8 873.1 918.5 6463.8 9751.6 9755.3 9779.4 9921.7 393581.0 396354.0 397160.0 419463.0 421170.0 47950.3 75133.0 81941.6 83611.6 84138.0 921.5 944.9 955.3 1010.2 1014.7 15508.9 15662.8 16068.3 16153.0 16421.7 36449.5 36817.6 36907.8 37350.3 37368.0 45446.8 47115.3 52092.0 52128.7 52890.2 7402.6 7523.9 7551.7 7636.3 7638.2 10478.2 10691.4 11202.2 11465.0 11688.6 9643.0 9721.7 9784.5 9950.6 9961.4 9919.4 9945.9 10113.9 10120.3 10232.1 9584.9 10082.9 10095.5 10346.1 10376.8 7337.8 7343.5 7410.5 7414.9 7443.4 8371.0 9589.1 9755.2 9941.8 9943.5 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#3] mootools.html Cycles:180 Average:5212.98 Median:5217.21 stddev:2931.71 (56.2%) stddev-sans-first:2925.50 09:39:52 INFO - PROCESS | 21444 | Values: 1341.7 1385.2 1385.4 1619.6 1627.0 6708.5 7517.7 7545.7 8116.7 8122.0 7740.2 7981.4 8012.0 8028.6 8040.3 2184.8 2215.9 2220.3 2223.9 2228.4 2194.6 2234.6 2239.8 2244.4 2245.1 2198.8 2209.7 2230.1 2230.1 2238.5 2139.4 2143.6 2149.3 2154.3 2162.7 2158.4 2161.0 2169.1 2173.4 2179.4 7972.8 8072.2 8077.3 8086.9 8095.6 4579.3 4730.8 4740.2 4751.2 4752.7 2868.5 2881.2 2939.1 2974.9 2993.9 864.9 932.3 939.6 949.1 950.7 11074.8 11115.2 11116.0 11129.6 11144.3 4143.6 4334.3 4428.2 4474.2 4483.1 9371.1 9392.9 9400.1 9403.5 9414.5 4804.2 4823.7 4834.2 4841.3 4851.2 3727.3 4246.5 4340.8 4365.8 4389.8 3637.5 3688.9 3740.6 3818.8 3823.1 1216.9 1222.5 1223.7 1228.1 1239.0 756.9 791.5 791.9 793.0 794.4 5177.9 5256.5 5303.3 5382.8 5419.3 412.0 420.9 426.1 428.6 429.4 3780.5 3803.3 3810.2 3854.9 3879.5 9149.5 9488.3 9563.3 9568.3 9882.3 9750.0 9759.9 9761.1 9761.4 9776.7 7015.6 7357.3 7371.9 7378.4 7380.7 5526.9 5643.0 5699.1 5730.9 5793.3 8666.9 8688.1 8875.3 8917.8 8935.8 8948.3 8990.7 8990.9 9065.4 9079.5 6079.2 6477.2 6660.7 6835.9 7028.7 7614.9 7667.7 7685.5 7686.6 7690.0 6538.7 6601.2 6642.1 6678.9 6787.4 6687.9 6703.9 6722.7 6887.3 6912.7 6345.4 6362.2 6420.5 6424.6 6438.1 4684.6 4767.2 4802.3 4811.0 4875.3 4675.5 4679.0 4797.6 4838.8 4851.4 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#4] prototype.html Cycles:180 Average:4342.31 Median:4972.55 stddev:1280.10 (25.7%) stddev-sans-first:1246.92 09:39:52 INFO - PROCESS | 21444 | Values: 283.7 298.9 301.9 304.8 306.7 4967.7 4977.5 5119.5 5148.6 5160.4 4992.8 5012.2 5029.7 5042.9 5054.8 3941.6 3984.8 4005.0 4007.5 4008.1 3902.4 3983.5 3990.4 3995.2 4021.4 3923.1 3929.6 3950.2 3963.1 3974.6 3915.0 3935.4 3949.9 3953.7 3961.6 3254.5 3377.7 3390.6 3510.0 3522.2 4853.1 4866.2 4879.9 4883.6 4940.8 4474.2 4479.8 4485.6 4495.1 4499.7 5144.4 5217.6 5245.6 5279.8 5323.9 3722.8 3729.4 3736.7 3738.3 3746.9 5517.2 5577.4 5577.9 5609.0 5609.0 3585.9 3831.9 3833.2 3834.5 3845.3 3816.2 3847.5 3854.0 3857.7 3863.4 4424.8 4425.3 4439.5 4449.4 4456.7 5269.8 5273.4 5343.4 5348.8 5364.0 1297.6 1343.6 1345.6 1349.1 1352.5 804.5 838.0 847.4 856.6 861.8 4100.8 4101.8 4115.0 4130.3 4169.5 4838.1 4865.9 4885.6 4886.5 4902.7 4175.5 4192.4 4197.8 4205.3 4217.1 2572.4 2688.9 2899.6 2906.3 2917.9 5098.0 5109.7 5112.6 5114.2 5129.5 5357.7 5554.5 5578.4 5586.7 5592.5 5088.4 5092.8 5097.5 5104.3 5113.7 5464.3 5466.7 5473.6 5477.8 5483.7 5111.2 5349.2 5350.5 5354.3 5356.3 5157.3 5160.9 5176.1 5183.4 5192.4 3563.1 3647.3 3816.1 3873.7 3884.0 5393.4 5429.2 5440.2 5450.2 5463.4 5280.9 5283.2 5298.8 5305.8 5344.1 5037.0 5222.1 5281.3 5287.6 5289.5 5201.2 5220.5 5229.5 5243.7 5256.9 5324.5 5337.7 5365.2 5386.7 5401.4 5073.9 5150.9 5167.5 5176.0 5183.3 09:39:52 INFO - PROCESS | 21444 | 09:39:52 INFO - PROCESS | 21444 | [#5] yui.html Cycles:180 Average:17458.65 Median:566.45 stddev:24759.08 (4371.0%) stddev-sans-first:24796.03 09:39:52 INFO - PROCESS | 21444 | Values: 562.1 598.8 620.5 730.9 735.5 12723.6 13735.8 13970.0 13989.7 14004.9 12317.3 12510.9 12620.2 12647.5 12655.2 768.9 790.3 791.1 791.9 792.4 637.5 768.1 785.9 787.0 788.8 793.2 799.5 803.6 810.8 820.3 820.9 822.9 825.6 825.8 827.6 603.6 604.9 608.4 611.0 612.0 14001.9 14018.6 14107.3 14226.4 14237.9 13564.9 13800.9 13840.3 13895.7 14261.7 10491.8 10537.4 10707.7 10709.3 10824.5 3318.4 3322.9 3351.4 3356.9 3371.7 66071.3 68811.3 68916.0 70448.3 71063.3 9698.0 9907.7 9966.2 10080.2 10085.5 21158.4 21169.5 21170.5 21207.6 21218.7 6668.9 6721.5 6806.8 6907.6 6962.8 3407.9 3506.4 3591.2 3592.4 3618.3 2913.7 2997.6 3006.1 3031.0 3034.6 499.5 500.0 514.7 516.6 519.4 486.3 502.5 521.7 531.5 532.7 7535.3 8026.0 8082.5 8302.3 8356.7 475.7 562.5 570.4 609.4 618.5 3891.9 3942.7 4051.3 4081.8 4187.2 86681.6 88412.6 91536.5 91895.5 93664.0 78374.0 78537.6 80841.6 81510.0 83143.0 71649.6 72836.0 73524.3 74028.3 75743.9 7833.0 7975.2 8005.9 8083.7 8141.2 32966.7 42635.6 43197.8 43800.8 44826.6 58129.4 60111.0 64365.7 64726.0 66929.7 9518.5 9729.5 9769.1 10031.5 10197.3 10624.9 11227.0 11351.9 11358.5 11488.2 10220.6 10390.2 10458.7 10537.2 10554.0 10796.2 10843.7 11211.7 11463.9 11563.8 9889.2 10269.7 10274.1 10480.4 10488.1 8870.9 9464.6 9474.5 9479.5 9491.7 8975.1 9552.1 9640.3 9669.1 9673.5 09:39:52 INFO - PROCESS | 21444 | -------- Summary: end -------- 09:39:52 INFO - PROCESS | 21444 | 09:39:53 INFO - TEST-INFO | 21444: exit 0 09:39:53 INFO - TEST-OK | dromaeo_css | took 1118255ms 09:39:53 INFO - TEST-START | kraken 09:39:53 INFO - operating with platform_type : linux_ 09:39:53 INFO - Initialising browser for kraken test... 09:39:53 INFO - TEST-INFO | started process 21680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkj5u46/profile http://localhost:40117/getInfo.html) 09:39:57 INFO - PROCESS | 21680 | JavaScript error: , line 0: uncaught exception: undefined 09:39:59 INFO - PROCESS | 21680 | __metrics Screen width/height:1600/1200 09:39:59 INFO - PROCESS | 21680 | colorDepth:24 09:39:59 INFO - PROCESS | 21680 | Browser inner width/height: 1024/697 09:39:59 INFO - PROCESS | 21680 | __metrics 09:40:00 ERROR - PROCESS | 21680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:40:01 INFO - TEST-INFO | 21680: exit 0 09:40:01 INFO - Browser initialized. 09:40:01 INFO - Running cycle 1/1 for kraken test... 09:40:01 INFO - TEST-INFO | started process 21794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkj5u46/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:13 INFO - PROCESS | 21794 | RSS: Main: 165752832 09:40:13 INFO - PROCESS | 21794 | 09:40:15 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40117/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:16 INFO - PROCESS | 21794 | RSS: Main: 170430464 09:40:16 INFO - PROCESS | 21794 | 09:40:19 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40117/tests/kraken/driver.html?testName=audio-dft) 09:40:20 INFO - PROCESS | 21794 | RSS: Main: 169631744 09:40:20 INFO - PROCESS | 21794 | 09:40:23 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40117/tests/kraken/driver.html?testName=audio-fft) 09:40:23 INFO - PROCESS | 21794 | RSS: Main: 165961728 09:40:23 INFO - PROCESS | 21794 | 09:40:26 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40117/tests/kraken/driver.html?testName=audio-oscillator) 09:40:26 INFO - PROCESS | 21794 | RSS: Main: 166871040 09:40:26 INFO - PROCESS | 21794 | 09:40:28 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:29 INFO - PROCESS | 21794 | RSS: Main: 167563264 09:40:29 INFO - PROCESS | 21794 | 09:40:32 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40117/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:33 INFO - PROCESS | 21794 | RSS: Main: 167493632 09:40:33 INFO - PROCESS | 21794 | 09:40:36 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40117/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:37 INFO - PROCESS | 21794 | RSS: Main: 164261888 09:40:37 INFO - PROCESS | 21794 | 09:40:40 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40117/tests/kraken/driver.html?testName=json-parse-financial) 09:40:41 INFO - PROCESS | 21794 | RSS: Main: 166412288 09:40:41 INFO - PROCESS | 21794 | 09:40:42 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:43 INFO - PROCESS | 21794 | RSS: Main: 166678528 09:40:43 INFO - PROCESS | 21794 | 09:40:45 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:46 INFO - PROCESS | 21794 | RSS: Main: 166850560 09:40:46 INFO - PROCESS | 21794 | 09:40:48 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:49 INFO - PROCESS | 21794 | RSS: Main: 167485440 09:40:49 INFO - PROCESS | 21794 | 09:40:51 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:52 INFO - PROCESS | 21794 | RSS: Main: 167587840 09:40:52 INFO - PROCESS | 21794 | 09:40:55 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:55 INFO - PROCESS | 21794 | RSS: Main: 167591936 09:40:55 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | Cycle 1(1): loaded http://localhost:40117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40117/tests/kraken/driver.html?testName=ai-astar) 09:40:57 INFO - PROCESS | 21794 | RSS: Main: 168337408 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | __start_tp_report 09:40:57 INFO - PROCESS | 21794 | _x_x_mozilla_page_load 09:40:57 INFO - PROCESS | 21794 | _x_x_mozilla_page_load_details 09:40:57 INFO - PROCESS | 21794 | |i|pagename|runs| 09:40:57 INFO - PROCESS | 21794 | |0;ai-astar;107;117;110;114;115;114;118;113;114;115 09:40:57 INFO - PROCESS | 21794 | |1;audio-beat-detection;147;121;147;188;123;152;147;123;178;124 09:40:57 INFO - PROCESS | 21794 | |2;audio-dft;164;164;168;169;162;164;165;165;164;163 09:40:57 INFO - PROCESS | 21794 | |3;audio-fft;75;77;76;168;87;80;77;77;159;77 09:40:57 INFO - PROCESS | 21794 | |4;audio-oscillator;86;85;152;87;85;86;145;86;85;142 09:40:57 INFO - PROCESS | 21794 | |5;imaging-gaussian-blur;118;118;118;118;117;117;118;121;117;117 09:40:57 INFO - PROCESS | 21794 | |6;imaging-darkroom;148;147;148;147;152;148;148;149;147;148 09:40:57 INFO - PROCESS | 21794 | |7;imaging-desaturate;96;96;96;96;95;97;95;95;96;96 09:40:57 INFO - PROCESS | 21794 | |8;json-parse-financial;63;65;64;63;63;65;69;63;63;64 09:40:57 INFO - PROCESS | 21794 | |9;json-stringify-tinderbox;64;65;64;66;65;65;64;65;65;65 09:40:57 INFO - PROCESS | 21794 | |10;stanford-crypto-aes;82;86;80;80;79;81;87;79;84;83 09:40:57 INFO - PROCESS | 21794 | |11;stanford-crypto-ccm;133;149;143;132;138;133;134;136;182;130 09:40:57 INFO - PROCESS | 21794 | |12;stanford-crypto-pbkdf2;172;170;165;165;167;170;174;162;169;165 09:40:57 INFO - PROCESS | 21794 | |13;stanford-crypto-sha256-iterative;68;70;68;74;70;68;66;67;66;66 09:40:57 INFO - PROCESS | 21794 | __end_tp_report 09:40:57 INFO - PROCESS | 21794 | __start_cc_report 09:40:57 INFO - PROCESS | 21794 | _x_x_mozilla_cycle_collect,991 09:40:57 INFO - PROCESS | 21794 | __end_cc_report 09:40:57 INFO - PROCESS | 21794 | __startTimestamp1469464857955__endTimestamp 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | ------- Summary: start ------- 09:40:57 INFO - PROCESS | 21794 | Number of tests: 14 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:3.20 (2.8%) stddev-sans-first:2.30 09:40:57 INFO - PROCESS | 21794 | Values: 107.0 117.0 110.0 114.0 115.0 114.0 118.0 113.0 114.0 115.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:147.00 stddev:23.53 (16.0%) stddev-sans-first:24.95 09:40:57 INFO - PROCESS | 21794 | Values: 147.0 121.0 147.0 188.0 123.0 152.0 147.0 123.0 178.0 124.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.15 (1.3%) stddev-sans-first:2.26 09:40:57 INFO - PROCESS | 21794 | Values: 164.0 164.0 168.0 169.0 162.0 164.0 165.0 165.0 164.0 163.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#3] audio-fft Cycles:10 Average:95.30 Median:77.00 stddev:36.16 (47.0%) stddev-sans-first:37.60 09:40:57 INFO - PROCESS | 21794 | Values: 75.0 77.0 76.0 168.0 87.0 80.0 77.0 77.0 159.0 77.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.50 stddev:29.39 (34.4%) stddev-sans-first:30.45 09:40:57 INFO - PROCESS | 21794 | Values: 86.0 85.0 152.0 87.0 85.0 86.0 145.0 86.0 85.0 142.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 09:40:57 INFO - PROCESS | 21794 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 118.0 121.0 117.0 117.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.48 (1.0%) stddev-sans-first:1.56 09:40:57 INFO - PROCESS | 21794 | Values: 148.0 147.0 148.0 147.0 152.0 148.0 148.0 149.0 147.0 148.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:40:57 INFO - PROCESS | 21794 | Values: 96.0 96.0 96.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:1.87 (2.9%) stddev-sans-first:1.94 09:40:57 INFO - PROCESS | 21794 | Values: 63.0 65.0 64.0 63.0 63.0 65.0 69.0 63.0 63.0 64.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 09:40:57 INFO - PROCESS | 21794 | Values: 64.0 65.0 64.0 66.0 65.0 65.0 64.0 65.0 65.0 65.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:2.85 (3.4%) stddev-sans-first:3.02 09:40:57 INFO - PROCESS | 21794 | Values: 82.0 86.0 80.0 80.0 79.0 81.0 87.0 79.0 84.0 83.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:137.00 stddev:15.50 (11.3%) stddev-sans-first:16.17 09:40:57 INFO - PROCESS | 21794 | Values: 133.0 149.0 143.0 132.0 138.0 133.0 134.0 136.0 182.0 130.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:169.50 stddev:3.73 (2.2%) stddev-sans-first:3.64 09:40:57 INFO - PROCESS | 21794 | Values: 172.0 170.0 165.0 165.0 167.0 170.0 174.0 162.0 169.0 165.0 09:40:57 INFO - PROCESS | 21794 | 09:40:57 INFO - PROCESS | 21794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.50 (3.7%) stddev-sans-first:2.65 09:40:57 INFO - PROCESS | 21794 | Values: 68.0 70.0 68.0 74.0 70.0 68.0 66.0 67.0 66.0 66.0 09:40:57 INFO - PROCESS | 21794 | -------- Summary: end -------- 09:40:57 INFO - PROCESS | 21794 | 09:40:59 INFO - TEST-INFO | 21794: exit 0 09:40:59 INFO - TEST-OK | kraken | took 65364ms 09:40:59 INFO - SUITE-END | took 1183s 09:40:59 INFO - Completed test suite (00:19:43) 09:40:59 INFO - javascript benchmark 09:40:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6362.261666819866, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.921312360629, 2631.3947792007825, 2658.747418995196, 2666.106854203843, 2677.143314139476, 4757.977034937488, 4846.660733748643, 4866.197077482216, 4893.877653058676, 4912.21404575268, 4809.495003024685, 4845.345878306428, 4865.756712164395, 4881.389826271716, 4884.951150488494, 4418.801153948064, 4449.710768800018, 4461.4869290031575, 4463.955360446403, 4544.681872268942, 4459.353393757903, 4467.396901418299, 4478.171538265415, 4489.416375871132, 4552.567506086933, 4556.2937744649635, 4578.587927086562, 4586.564276393738, 4592.793324300398, 4609.953900460986, 4345.891352716176, 4379.5182529921685, 4400.911981760379, 4487.39420178275, 4526.958799476139, 4348.543402942709, 4356.912861742779, 4364.803583838735, 4428.31361139024, 4451.554844515555, 4822.903541929142, 4852.296417019513, 4854.101991131652, 4870.805167793284, 4887.3890763654545, 5155.587552995751, 5161.225816127573, 5165.974170129125, 5188.610854185951, 5232.816851410183, 5255.1329030709885, 5271.235670827747, 5275.525202731773, 5283.286756287929, 5283.735813209362, 4931.556159945622, 4938.9012219755405, 4939.975300123477, 4943.06081844452, 4952.2819191217795, 5201.0, 5288.762005709752, 5315.123004704181, 5328.307320048369, 5424.050791111618, 5101.183810590288, 5132.923006154911, 5137.12668846297, 5137.280780690707, 5152.175651895679, 5202.401723801736, 5213.244079608511, 5231.346081739783, 5236.3716354037, 5259.684418934876, 4952.281919121707, 5043.899122017539, 5048.873778155502, 5079.6698214615935, 5108.029474399852, 5093.694378337312, 5107.668001579886, 5131.589472842164, 5136.8202112925865, 5156.355455568054, 4371.628411584988, 4372.584604462634, 4375.343698445258, 4387.802548885308, 4427.380166776654, 3754.662080412776, 3784.6026167252594, 3816.5229346331707, 3832.9233415331537, 3854.0750219947013, 4409.007973206003, 4454.465464144323, 4457.286834106528, 4464.464264288306, 4476.597106260387, 5206.140986737221, 5208.296879921238, 5210.478952104835, 5214.0, 5221.817236396708, 4443.933340999887, 4449.532799056053, 4465.37484752135, 4475.0, 4502.122086193161, 4532.0, 4598.839040633562, 4600.470945841204, 4625.283081122431, 4638.628909687217, 4859.684120532083, 4860.1251774680895, 4862.41651001882, 4899.020195960751, 4905.632077594266, 5209.6874187548865, 5210.947890521198, 5214.217867319932, 5214.739263036909, 5216.139337009351, 4762.738049407316, 4831.396075490564, 4847.030593881308, 4874.0495603357, 4878.853634390974, 5088.898222035613, 5094.159463688598, 5122.769475373542, 5128.076946149579, 5179.792808287777, 5194.97402512985, 5196.142636464941, 5197.896042079213, 5207.557357624644, 5265.552428043659, 4905.583025442877, 4958.206686930074, 5003.649744517848, 5024.246363045572, 5067.366579177603, 4993.575546078624, 4995.050940321327, 4996.550310471929, 5007.974960125176, 5038.622103342191, 4801.087793319258, 4881.267809828554, 4900.975495122501, 4947.727874966768, 4985.925211121908, 4924.72913989734, 4999.375078115236, 5075.670081444694, 5076.314697515788, 5088.745562721923, 4974.054929563371, 4985.551300382983, 4991.925121123113, 4997.20044792846, 5005.374328208974], "value": 4752.302171642943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5088772767692, 565.9575531835113, 566.4081035318093, 572.0418299348593, 577.9219805326281, 26821.731782682167, 27532.449351012994, 38106.0, 39328.0, 39476.80261598688, 38490.615093849054, 38499.807500962525, 38713.0, 38871.22257554847, 38931.0, 7710.151883292833, 7831.0, 7834.0990786059765, 7848.254415830515, 7871.330936870373, 7761.185075567068, 7828.843423131534, 7832.373410127205, 7845.568493732842, 7846.882296765553, 7809.687612495493, 7826.1391246962785, 7890.487118337319, 7900.249476299742, 7910.0, 7775.4945928515035, 7799.259070388304, 7823.317986632873, 7873.96063019687, 7890.092639346462, 7672.386209103258, 7739.57432341221, 7740.845183096307, 7755.108162561265, 7806.882896756553, 37766.43350349747, 38037.42943855844, 38052.809735951145, 38130.61869381298, 38174.0, 2861.625600694695, 2887.133859842039, 2891.493988551995, 2898.7246211609863, 2915.6938521455154, 28069.71930280712, 28263.293417664518, 28618.427631447463, 29233.561496577568, 29344.559831602543, 3337.4826901830256, 3353.480210567366, 3426.400379933502, 3436.914077148066, 3445.689887910075, 241659.0, 242437.99999999822, 242565.0, 242582.0, 243063.0, 47671.523284767405, 48455.515444845805, 48484.27273590899, 48534.51465485371, 48539.75730121327, 30813.845930770203, 31689.366212675617, 31933.680663193536, 46426.303605445944, 46965.76517117461, 14268.500602478864, 14703.264836758119, 14744.926275368769, 14773.852261477463, 14798.334074966437, 11107.333559986426, 11220.382878941737, 11242.887571124184, 11304.321740695585, 11309.71725706864, 16579.751303730452, 16613.0, 16639.753633259596, 16648.667026659397, 16794.58013549671, 6166.454288783967, 6339.556231063873, 6374.521910856704, 6561.770338038145, 6565.638889861008, 814.3770015937812, 939.0, 1025.4411345816548, 1030.7320096774743, 1031.2265800649513, 25537.361565961, 27162.5925611116, 27599.17202483929, 27640.861795690893, 27716.30709232245, 933.9673111441067, 946.3328353510758, 946.9005754395827, 1030.314840630987, 1031.3193292426963, 13820.792688109686, 14699.853001470063, 14781.852181478263, 14799.112053276838, 14979.251037448084, 290563.0, 295056.0, 295760.0, 295932.0, 296114.0, 44290.557094428645, 44407.55592444034, 44884.551154488036, 44933.32600011003, 44967.77516112399, 1147.770445910821, 1149.4195431307137, 1175.3829239649253, 1199.4782269712703, 1211.594115971142, 25024.0, 26166.86916565405, 26401.60397594076, 26522.867385662947, 26744.19767406981, 39289.607103928596, 39638.0, 39672.20655586814, 39673.603263966994, 39774.40338394869, 215016.0, 215100.0, 216042.0, 216170.0, 216270.0, 22715.0, 22933.655995159752, 24375.634365484177, 24499.877500612383, 24882.626760598967, 38201.0, 38314.677424186404, 38666.0, 38958.0, 39935.60064399435, 33879.830600846835, 33976.66023339735, 34810.03213386746, 35241.82379088088, 35332.116697082776, 34391.140221494665, 35095.12262193466, 35671.10822229465, 35722.0, 36248.63751362558, 33957.0, 34176.14559636029, 35132.0, 35432.82283588668, 35574.466383004794, 29173.0, 30751.2312192197, 31752.841235793672, 31807.0, 31941.8402907984, 24379.634305485786, 24395.14616988397, 24608.384790379667, 24718.505629887663, 25001.624975625746], "value": 16532.739479779415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.24964572979655, 366.45398356448885, 369.735639018102, 381.7823840410965, 385.4815273457199, 15746.527604171864, 16541.586460338483, 17011.914940425282, 17087.487375378758, 17169.57076073099, 16222.188890555484, 16587.17064146794, 16933.49199524016, 17017.404390846325, 17059.232334544944, 4925.482824303459, 5118.6416950813455, 5119.0529751996, 5122.795088196468, 5123.462036486171, 3764.661180493755, 5071.31537242473, 5678.375378708339, 5911.645301281937, 5936.792212272571, 6005.549583781212, 6010.429009244137, 6018.127371531147, 6024.668643224621, 6035.366286539916, 5932.614380065282, 5935.703214839263, 5978.222831031938, 5980.491658209035, 5983.042713165873, 5128.615353848476, 5175.197844334134, 5278.683279003234, 5283.365996080456, 5293.04725149473, 11447.656570302905, 11905.345206013666, 20581.0, 20729.792702072937, 20770.48073798152, 1792.507060558344, 1890.3194849854042, 1978.0307649251906, 1987.3541099142692, 2364.6334818103223, 9216.032316606726, 9227.538623068887, 9239.30705197113, 9249.583768730423, 9294.302927280414, 1612.5887898585786, 1632.6000129968234, 1638.230031885012, 1742.268247336122, 1762.647470505904, 60726.39273607296, 65391.01913471349, 66409.66795165994, 69076.0, 72309.63845180793, 9501.714948551555, 9505.239580833517, 9574.234061275081, 9888.269552828226, 9894.703158905244, 13390.866091339156, 13399.799003014963, 13480.39338229782, 13485.865141348657, 13486.39311230997, 6849.554778939353, 6981.720731170696, 7051.647417629098, 7246.782596522113, 7251.093613298338, 6746.392824645805, 6776.86770910896, 7031.0, 7054.400375967997, 7069.151701795818, 4012.8996775080273, 4035.6973227008093, 4154.293770059097, 4157.48031496063, 4173.123644034726, 1613.8305477924648, 1686.468762339859, 1763.0, 1784.5627821183894, 1830.249597664951, 775.1783109903521, 815.9020917489939, 860.3934226370394, 889.0709208876739, 897.7486303834937, 16590.52226104097, 16706.164691765363, 17155.57111072208, 18244.63510729778, 18570.25718971226, 818.2635627934907, 840.2227939156378, 870.7779516223322, 873.0876234335135, 918.4626993209048, 6463.806085817433, 9751.609935602497, 9755.268354873413, 9779.41323520591, 9921.702348929544, 393581.0, 396354.0, 397160.0, 419463.0, 421170.0, 47950.28074578884, 75133.0, 81941.59029204935, 83611.58194209111, 84138.0, 921.4839689773614, 944.9055094490496, 955.2739917662626, 1010.1817527802503, 1014.7158795537114, 15508.92245538765, 15662.82528810321, 16068.276927538054, 16153.0, 16421.67156656884, 36449.45325820062, 36817.63182368142, 36907.8154609236, 37350.25299493941, 37368.0, 45446.77276613596, 47115.29327060028, 52092.0, 52128.73935630298, 52890.2066469011, 7402.629868506446, 7523.887141692989, 7551.697932082655, 7636.274553917369, 7638.159802421618, 10478.161747060369, 10691.358518488916, 11202.15983801202, 11465.0, 11688.649340519798, 9643.0, 9721.70834874955, 9784.51077446139, 9950.601975921172, 9961.35251208669, 9919.40483570988, 9945.900540994497, 10113.949430253097, 10120.291579589359, 10232.130268927225, 9584.9041509584, 10082.949585252027, 10095.545700443645, 10346.120579750504, 10376.844347334645, 7337.816554586178, 7343.522671026366, 7410.481266311306, 7414.8887766682465, 7443.44174186949, 8370.958145209235, 9589.136977671764, 9755.170810481188, 9941.801163976825, 9943.453110079015], "value": 8099.808023808003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6712905338188, 1385.1550554161963, 1385.425048604829, 1619.5951012246937, 1626.9674606507876, 6708.49686273529, 7517.699292028312, 7545.698172073117, 8116.715914942978, 8121.959390203041, 7740.187280335554, 7981.401394895377, 8011.959940200305, 8028.598570071487, 8040.276375126237, 2184.8142907852853, 2215.936350551728, 2220.3006053093304, 2223.8665680059166, 2228.4206106412366, 2194.6378847490146, 2234.575430668168, 2239.8096161826265, 2244.427670943907, 2245.124401483423, 2198.7801219877965, 2209.6575030870163, 2230.0856648774006, 2230.0968107916237, 2238.541099074686, 2139.433050241679, 2143.645091082549, 2149.301477019967, 2154.2675490333286, 2162.6864104704887, 2158.4280165756086, 2160.9783902160934, 2169.0889826273005, 2173.4349069241953, 2179.444241718352, 7972.760817175494, 8072.19278072194, 8077.273045425881, 8086.878696819553, 8095.635696393676, 4579.290210017452, 4730.787114579818, 4740.217864052427, 4751.168545504523, 4752.71483710975, 2868.4549935512186, 2881.178864023764, 2939.103573410109, 2974.940501189964, 2993.9401211975855, 864.8702694595798, 932.2588542109039, 939.567798812547, 949.06991148674, 950.6625148072472, 11074.833877491845, 11115.221934464671, 11116.0, 11129.554817807279, 11144.33134011962, 4143.606357396043, 4334.306510958231, 4428.158649856581, 4474.217012022948, 4483.103379324149, 9371.109744574254, 9392.90607093934, 9400.106989835955, 9403.482808445464, 9414.529273536433, 4804.231322988305, 4823.734694591831, 4834.226523756252, 4841.3222148899185, 4851.199552073939, 3727.2918145552258, 4246.532881383046, 4340.804663790137, 4365.825366985285, 4389.846355377546, 3637.5453068366455, 3688.870889518854, 3740.569834469071, 3818.770873747584, 3823.0824602095295, 1216.8722284160035, 1222.5232159457819, 1223.7063104854772, 1228.1403017887515, 1238.9814152787715, 756.8675481790775, 791.4934441957153, 791.9247671471201, 793.0008189680929, 794.3605397654943, 5177.896442071213, 5256.526912577886, 5303.257543943774, 5382.757775900094, 5419.34967803866, 411.9608637179523, 420.9095044565433, 426.1179358727405, 428.57785081694504, 429.3602532226959, 3780.5085338905765, 3803.2963901678277, 3810.161764411825, 3854.865079722252, 3879.4568760373004, 9149.542522873962, 9488.33581649278, 9563.282753793494, 9568.282378821616, 9882.308238423242, 9750.0, 9759.9024009759, 9761.07269809367, 9761.365511241747, 9776.706698799047, 7015.649217539102, 7357.301056399633, 7371.852562948711, 7378.372838308804, 7380.74167404149, 5526.889462210814, 5643.0, 5699.116636921284, 5730.885382292414, 5793.333766616893, 8666.869996949925, 8688.087750786077, 8875.33434992391, 8917.777055573662, 8935.776605584653, 8948.328875334506, 8990.730278091667, 8990.910090899008, 9065.365424420228, 9079.45523268606, 6079.209702738615, 6477.190351206099, 6660.733570657119, 6835.897461537981, 7028.718851245892, 7614.923850761422, 7667.731629392944, 7685.5004424712215, 7686.57723825195, 7689.9615501922135, 6538.738450461929, 6601.207855057424, 6642.136522252076, 6678.866422671616, 6787.423069039187, 6687.899681504684, 6703.932960670526, 6722.697478613572, 6887.345702158287, 6912.688928998307, 6345.365463453618, 6362.204724409449, 6420.454261387835, 6424.582402143846, 6438.066480360415, 4684.578387945101, 4767.165745994506, 4802.27965805132, 4810.975945120252, 4875.268709693574, 4675.485696573306, 4679.0, 4797.56821886032, 4838.758062096811, 4851.393575803025], "value": 4122.190569909512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.71770088761673, 298.8938926681028, 301.8928280460438, 304.8490996956505, 306.69177476635986, 4967.652264341497, 4977.452480227172, 5119.462456442071, 5148.562372198363, 5160.432352441228, 4992.750362481879, 5012.198048312271, 5029.673071250366, 5042.899142017158, 5054.772535235914, 3941.575930802557, 3984.7808370539756, 4005.038790690228, 4007.519097708279, 4008.13825027619, 3902.414637804324, 3983.50206224222, 3990.4413382126527, 3995.220931918277, 4021.4168945502884, 3923.136909879822, 3929.5657085163853, 3950.170464202521, 3963.0686788604653, 3974.642282194616, 3914.9804250978705, 3935.4096885467125, 3949.940750888725, 3953.723239373245, 3961.623645753649, 3254.544363789071, 3377.7128944039787, 3390.593128824557, 3509.9649003509894, 3522.18989632386, 4853.0779151961015, 4866.197077482211, 4879.926801097987, 4883.5604795568215, 4940.777665005084, 4474.239379305526, 4479.843205487792, 4485.596296333346, 4495.056038231975, 4499.6850220484575, 5144.356955380577, 5217.5565076968505, 5245.606579506514, 5279.762410691528, 5323.920141197885, 3722.8324725387424, 3729.4219395993664, 3736.7197460190596, 3738.3084129436143, 3746.906327341811, 5517.227588137664, 5577.386487486373, 5577.9163312550345, 5608.971955140199, 5608.999999999959, 3585.8744943926836, 3831.904202394907, 3833.15670552478, 3834.5489059845804, 3845.288621605012, 3816.217675376541, 3847.480590120354, 3853.9807300963876, 3857.6913846892744, 3863.4204869269274, 4424.778761061934, 4425.291953287458, 4439.511653718088, 4449.354843547668, 4456.665750068693, 5269.815556455505, 5273.3935597406025, 5343.385510666323, 5348.82325888304, 5363.973180134074, 1297.6366617347157, 1343.603636927109, 1345.6366780969083, 1349.1432940083118, 1352.452256835983, 804.4931693033352, 837.9539125348165, 847.4449235750593, 856.5674334461182, 861.763015170833, 4100.815463304159, 4101.794910254475, 4114.979425102915, 4130.297849365615, 4169.541350451448, 4838.129496402864, 4865.854024379274, 4885.6335774817035, 4886.511348865156, 4902.656814022984, 4175.498940127204, 4192.392103145027, 4197.811098500575, 4205.3271476563605, 4217.102303963229, 2572.356910772307, 2688.8790004449847, 2899.623049003616, 2906.287959449948, 2917.854107294669, 5098.0, 5109.718965456936, 5112.590992720573, 5114.181730923035, 5129.512696293846, 5357.678539287577, 5554.50009499147, 5578.358488773762, 5586.664800112007, 5592.468715472024, 5088.389393272831, 5092.770825312796, 5097.451274362818, 5104.3155758600315, 5113.693178409233, 5464.33337831965, 5466.72666366688, 5473.589480789036, 5477.794885125266, 5483.725813709379, 5111.233315002779, 5349.170878513836, 5350.5184533392185, 5354.330708661418, 5356.330458692663, 5157.329547158845, 5160.870978225575, 5176.1200595899545, 5183.352080989876, 5192.3769147702515, 3563.1448452371765, 3647.3070116677745, 3816.1032157442423, 3873.65137137659, 3884.0484081400236, 5393.43368946255, 5429.158480435539, 5440.156775699615, 5450.209719590716, 5463.4263402342185, 5280.894382112259, 5283.181106928432, 5298.841034768963, 5305.840824775263, 5344.144936810092, 5037.0, 5222.138347172826, 5281.339832520935, 5287.57699384056, 5289.466054844052, 5201.193814958688, 5220.5382492902045, 5229.457310093608, 5243.737813109406, 5256.947430525645, 5324.520793128637, 5337.6797392156595, 5365.168398898021, 5386.703731294817, 5401.378841433286, 5073.898522029613, 5150.918307155539, 5167.534921857051, 5175.9741201293755, 5183.300254465599], "value": 3930.0197114188886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.0838034004572, 598.8113744170587, 620.5128973755603, 730.8973407883535, 735.4741359927652, 12723.554675586356, 13735.793963090562, 13969.952253580985, 13989.720205595895, 14004.929975350109, 12317.260964342124, 12510.93744531276, 12620.24278543288, 12647.494100236003, 12655.240685558872, 768.8692922203211, 790.3045320118288, 791.0546896458734, 791.9089304729944, 792.4373694676786, 637.4677144584277, 768.1013214539003, 785.9489133206351, 787.0476723164949, 788.763370988704, 793.1949071692237, 799.532273619933, 803.5540275147291, 810.7527204202715, 820.3478234803316, 820.9343252539783, 822.9218224268685, 825.6037102190952, 825.7852958230843, 827.5779352530222, 603.5774957529746, 604.8760004199129, 608.4341562347015, 611.0132136599404, 612.0146564031905, 14001.929990349983, 14018.649533761636, 14107.294635268196, 14226.359813808403, 14237.928810355985, 13564.864351356458, 13800.93099534496, 13840.30798460073, 13895.722085558233, 14261.714765704732, 10491.842622360595, 10537.420441875694, 10707.678769636923, 10709.25035247533, 10824.458777061116, 3318.369509793156, 3322.9335413291597, 3351.3967485852536, 3356.9160770980675, 3371.696547310754, 66071.339286607, 68811.311886881, 68916.0, 70448.29551704468, 71063.28936710619, 9698.0, 9907.653232136841, 9966.152877005536, 10080.243981701402, 10085.546150423248, 21158.365249042552, 21169.470763230733, 21170.470738231666, 21207.561130469883, 21218.681719774217, 6668.866622667617, 6721.462283017347, 6806.76176333826, 6907.620080895599, 6962.756303529352, 3407.9148021299666, 3506.403911335079, 3591.2278860045217, 3592.3533763922746, 3618.2763447310645, 2913.6649285332032, 2997.6252968378953, 3006.128222815359, 3030.9696903030685, 3034.5903303053806, 499.5079846351341, 499.9550040496373, 514.7091893080398, 516.5531814980015, 519.3923109961354, 486.3312944701036, 502.46989426155756, 521.7495602111007, 531.5136649965316, 532.7416203141473, 7535.321821036133, 8026.0, 8082.515049096955, 8302.335813134934, 8356.665733370719, 475.74547617024723, 562.5190462154881, 570.3725901508391, 609.3601718195877, 618.4773866083152, 3891.9416208756893, 3942.7240093193773, 4051.331530297527, 4081.816318265626, 4187.204431158131, 86681.56659216664, 88412.5579372099, 91536.54231728798, 91895.5405222983, 93664.0, 78374.0, 78537.60731196307, 80841.59579202184, 81510.0, 83143.0, 71649.64175179091, 72836.0, 73524.26475735175, 74028.25971740214, 75743.86384204241, 7832.960835196015, 7975.2423519765525, 8005.919940800751, 8083.6766529338165, 8141.186485135661, 32966.67033329636, 42635.57364426316, 43197.78401107974, 43800.780996094814, 44826.55173448224, 58129.4187058124, 60111.0, 64365.678171608844, 64726.0, 66929.66535167293, 9518.476483793458, 9729.4648794317, 9769.071938165864, 10031.498425078571, 10197.337173083726, 10624.946875265883, 11227.0, 11351.886481135414, 11358.488868000795, 11488.195826292414, 10220.591176352862, 10390.168786497214, 10458.68623941283, 10537.209709271681, 10554.0, 10796.244262901522, 10843.728906777078, 11211.71970700739, 11463.885361146282, 11563.768724625628, 9889.2037361878, 10269.691909242734, 10274.126699230648, 10480.371177729361, 10488.10851077667, 8870.911290887008, 9464.621415143318, 9474.478903660365, 9479.478628675213, 9491.66779162726, 8975.102489750972, 9552.092551207625, 9640.276979226446, 9669.129778319984, 9673.467959262027], "value": 6432.468977347623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 110.0, 114.0, 115.0, 114.0, 118.0, 113.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 147.0, 188.0, 123.0, 152.0, 147.0, 123.0, 178.0, 124.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 168.0, 169.0, 162.0, 164.0, 165.0, 165.0, 164.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 168.0, 87.0, 80.0, 77.0, 77.0, 159.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 152.0, 87.0, 85.0, 86.0, 145.0, 86.0, 85.0, 142.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 121.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 152.0, 148.0, 148.0, 149.0, 147.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 63.0, 65.0, 69.0, 63.0, 63.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 80.0, 80.0, 79.0, 81.0, 87.0, 79.0, 84.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 149.0, 143.0, 132.0, 138.0, 133.0, 134.0, 136.0, 182.0, 130.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 165.0, 165.0, 167.0, 170.0, 174.0, 162.0, 169.0, 165.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 74.0, 70.0, 68.0, 66.0, 67.0, 66.0, 66.0], "value": 68.3, "unit": "score"}]}]} 09:40:59 INFO - Return code: 0 09:40:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:40:59 ERROR - # TBPL SUCCESS # 09:40:59 INFO - Running post-action listener: _resource_record_post_action 09:40:59 INFO - [mozharness: 2016-07-25 16:40:59.283721Z] Finished run-tests step (success) 09:40:59 INFO - Running post-run listener: _resource_record_post_run 09:40:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555159552; Read time: 12; Write time: 1240600 09:40:59 INFO - TinderboxPrint: CPU usage
13.4% 09:40:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:40:59 INFO - TinderboxPrint: I/O write bytes / time
555,159,552 / 1,240,600 09:40:59 INFO - TinderboxPrint: CPU idle
8,296.6 (86.6%) 09:40:59 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 09:40:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:40:59 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 258871296; Read time: 0; Write time: 689684 09:40:59 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 295882752; Read time: 0; Write time: 550828 09:40:59 INFO - Running post-run listener: _upload_blobber_files 09:40:59 INFO - Blob upload gear active. 09:40:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:40:59 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 09:40:59 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'] 09:40:59 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 09:41:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:01 INFO - (blobuploader) - INFO - Done attempting. 09:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:10 INFO - (blobuploader) - INFO - Done attempting. 09:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:11 INFO - (blobuploader) - INFO - Done attempting. 09:41:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:11 INFO - Return code: 0 09:41:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be32b6d9967b6d4c045775af28f947edf7882cb74f94df09c11e3f68f452da3cbfe99b98dbd634680611b43d05fd44eeea7109485146e13a3f80270bde31875d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/738758e3d5c8e56df10a11248aefcc2efcf2e22e2e39ce87a150be91afac3490a775aba956bee7fbd0dff852c6ac34992f437e71df5b27b2a65536363b01f4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/664159f3c54e7ab14ac3e8e08e233895cd2080ed6baaffcf759dd638c2ae64a2fd1094ad8d679d0ef18ec66e85a2c0e823bbe0a4b04f3119db6ce22723ab5f46"} 09:41:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:11 INFO - Contents: 09:41:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/be32b6d9967b6d4c045775af28f947edf7882cb74f94df09c11e3f68f452da3cbfe99b98dbd634680611b43d05fd44eeea7109485146e13a3f80270bde31875d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/738758e3d5c8e56df10a11248aefcc2efcf2e22e2e39ce87a150be91afac3490a775aba956bee7fbd0dff852c6ac34992f437e71df5b27b2a65536363b01f4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/664159f3c54e7ab14ac3e8e08e233895cd2080ed6baaffcf759dd638c2ae64a2fd1094ad8d679d0ef18ec66e85a2c0e823bbe0a4b04f3119db6ce22723ab5f46"} 09:41:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:11 INFO - Copying logs to upload dir... 09:41:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.222781 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-25 09:41:11.470270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 09:41:11.473562) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 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/be32b6d9967b6d4c045775af28f947edf7882cb74f94df09c11e3f68f452da3cbfe99b98dbd634680611b43d05fd44eeea7109485146e13a3f80270bde31875d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/738758e3d5c8e56df10a11248aefcc2efcf2e22e2e39ce87a150be91afac3490a775aba956bee7fbd0dff852c6ac34992f437e71df5b27b2a65536363b01f4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/664159f3c54e7ab14ac3e8e08e233895cd2080ed6baaffcf759dd638c2ae64a2fd1094ad8d679d0ef18ec66e85a2c0e823bbe0a4b04f3119db6ce22723ab5f46"} build_url:https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/JOPvKSY7RUWfM_26hwuxrw/artifacts/public/build/firefox-50.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/be32b6d9967b6d4c045775af28f947edf7882cb74f94df09c11e3f68f452da3cbfe99b98dbd634680611b43d05fd44eeea7109485146e13a3f80270bde31875d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/738758e3d5c8e56df10a11248aefcc2efcf2e22e2e39ce87a150be91afac3490a775aba956bee7fbd0dff852c6ac34992f437e71df5b27b2a65536363b01f4a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/664159f3c54e7ab14ac3e8e08e233895cd2080ed6baaffcf759dd638c2ae64a2fd1094ad8d679d0ef18ec66e85a2c0e823bbe0a4b04f3119db6ce22723ab5f46"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 09:41:11.499622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:41:11.500188) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469463620.879681-1254084009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 09:41:11.582782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 09:41:11.583120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 09:41:11.583423) ========= ========= Total master_lag: 0.18 =========