builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1469745640.51 results: success (0) buildid: 20160728141329 builduid: 37d36bdcea7e426ea659a3bbfa30027d revision: 8e0019ff663e368c44b63fe10453add7b9fb0782 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.506959) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.507503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.507821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.557174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.557746) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 15:40:40-- 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% 228M=0s 2016-07-28 15:40:40 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.762960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.763319) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.056700 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:40.833484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 15:40:40.833962) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8e0019ff663e368c44b63fe10453add7b9fb0782 --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 8e0019ff663e368c44b63fe10453add7b9fb0782 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 15:40:40,794 truncating revision to first 12 chars 2016-07-28 15:40:40,794 Setting DEBUG logging. 2016-07-28 15:40:40,794 attempt 1/10 2016-07-28 15:40:40,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8e0019ff663e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 15:40:41,901 unpacking tar archive at: autoland-8e0019ff663e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.455715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 15:40:42.304241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:42.304582) ========= script_repo_revision: 8e0019ff663e368c44b63fe10453add7b9fb0782 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:42.304978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:42.305246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 15:40:42.314412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-28 15:40:42.314763) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:40:42 INFO - MultiFileLogger online at 20160728 15:40:42 in /builds/slave/test 15:40:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:40:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:40:42 INFO - {'append_to_log': False, 15:40:42 INFO - 'base_work_dir': '/builds/slave/test', 15:40:42 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:40:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:40:42 INFO - 'branch': 'Autoland-Non-PGO', 15:40:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:40:42 INFO - 'config_files': ('talos/linux_config.py',), 15:40:42 INFO - 'default_actions': ('clobber', 15:40:42 INFO - 'read-buildbot-config', 15:40:42 INFO - 'download-and-extract', 15:40:42 INFO - 'populate-webroot', 15:40:42 INFO - 'create-virtualenv', 15:40:42 INFO - 'install', 15:40:42 INFO - 'run-tests'), 15:40:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:40:42 INFO - 'download_minidump_stackwalk': True, 15:40:42 INFO - 'download_symbols': 'ondemand', 15:40:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:40:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:40:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:40:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:40:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:40:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:40:42 INFO - 'installer_path': 'installer.exe', 15:40:42 INFO - 'log_level': 'info', 15:40:42 INFO - 'log_name': 'talos', 15:40:42 INFO - 'log_to_console': True, 15:40:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:40:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:40:42 INFO - 'opt_config_files': (), 15:40:42 INFO - 'pip_index': False, 15:40:42 INFO - 'sps_profile': False, 15:40:42 INFO - 'sps_profile_interval': 0, 15:40:42 INFO - 'suite': 'dromaeojs', 15:40:42 INFO - 'system_bits': '32', 15:40:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:40:42 INFO - 'title': 'talos-linux64-ix-015', 15:40:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:40:42 INFO - 'use_talos_json': True, 15:40:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:40:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:40:42 INFO - 'work_dir': 'build'} 15:40:42 INFO - [mozharness: 2016-07-28 22:40:42.467935Z] Running clobber step. 15:40:42 INFO - Running pre-action listener: _resource_record_pre_action 15:40:42 INFO - Running main action method: clobber 15:40:42 INFO - rmtree: /builds/slave/test/build 15:40:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:40:44 INFO - Running post-action listener: _resource_record_post_action 15:40:44 INFO - [mozharness: 2016-07-28 22:40:44.770584Z] Finished clobber step (success) 15:40:44 INFO - [mozharness: 2016-07-28 22:40:44.770747Z] Running read-buildbot-config step. 15:40:44 INFO - Running pre-action listener: _resource_record_pre_action 15:40:44 INFO - Running main action method: read_buildbot_config 15:40:44 INFO - Using buildbot properties: 15:40:44 INFO - { 15:40:44 INFO - "project": "", 15:40:44 INFO - "product": "firefox", 15:40:44 INFO - "script_repo_revision": "production", 15:40:44 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:40:44 INFO - "repository": "", 15:40:44 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:40:44 INFO - "buildid": "20160728141329", 15:40:44 INFO - "pgo_build": "False", 15:40:44 INFO - "basedir": "/builds/slave/test", 15:40:44 INFO - "buildnumber": 150, 15:40:44 INFO - "slavename": "talos-linux64-ix-015", 15:40:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:40:44 INFO - "platform": "ubuntu64_hw", 15:40:44 INFO - "scheduler": "tests-autoland-linux64-talos", 15:40:44 INFO - "branch": "autoland", 15:40:44 INFO - "repo_path": "integration/autoland", 15:40:44 INFO - "revision": "8e0019ff663e368c44b63fe10453add7b9fb0782", 15:40:44 INFO - "stage_platform": "linux64", 15:40:44 INFO - "builduid": "37d36bdcea7e426ea659a3bbfa30027d", 15:40:44 INFO - "slavebuilddir": "test" 15:40:44 INFO - } 15:40:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:40:44 INFO - Running post-action listener: _resource_record_post_action 15:40:44 INFO - [mozharness: 2016-07-28 22:40:44.774427Z] Finished read-buildbot-config step (success) 15:40:44 INFO - [mozharness: 2016-07-28 22:40:44.774557Z] Running download-and-extract step. 15:40:44 INFO - Running pre-action listener: _resource_record_pre_action 15:40:44 INFO - Running main action method: download_and_extract 15:40:44 INFO - mkdir: /builds/slave/test/build/tests 15:40: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')]} 15:40:44 INFO - https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:40:45 INFO - Downloaded 1361 bytes. 15:40:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:40:45 INFO - Using the following test package requirements: 15:40:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:40:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:40:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:40:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'jsshell-linux-x86_64.zip'], 15:40:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:40:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:40:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:40:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:40:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:40:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:40:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:40:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:45 INFO - https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:40:46 INFO - Downloaded 22749930 bytes. 15:40:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:40:48 INFO - Return code: 0 15:40:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:49 INFO - https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:40:52 INFO - Downloaded 22749930 bytes. 15:40:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:40:54 INFO - Return code: 0 15:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:54 INFO - https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:40:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:40:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:40:55 INFO - Downloaded 14413725 bytes. 15:40:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:40:56 INFO - Return code: 0 15:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:56 INFO - https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:40:57 INFO - Downloaded 57167184 bytes. 15:40:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:40:57 INFO - mkdir: /builds/slave/test/properties 15:40:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:40:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:40:57 INFO - Contents: 15:40:57 INFO - build_url:https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:40:58 INFO - Running post-action listener: _resource_record_post_action 15:40:58 INFO - Running post-action listener: set_extra_try_arguments 15:40:58 INFO - [mozharness: 2016-07-28 22:40:58.200270Z] Finished download-and-extract step (success) 15:40:58 INFO - [mozharness: 2016-07-28 22:40:58.200504Z] Running populate-webroot step. 15:40:58 INFO - Running pre-action listener: _resource_record_pre_action 15:40:58 INFO - Running main action method: populate_webroot 15:40:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:40:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:40:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:40:58 INFO - '--tppagecycles', 15:40:58 INFO - '7'], 15:40:58 INFO - 'tests': ['tsvgm']}}, 15:40:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:40:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:40:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:40:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:40:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['damp', 'tps']}, 15:40:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'tests': ['damp', 'tps']}, 15:40:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['dromaeo_dom']}, 15:40:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:40:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['basic_compositor_video']}, 15:40:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:40:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'other-e10s': {'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['a11yr', 15:40:58 INFO - 'ts_paint', 15:40:58 INFO - 'tpaint', 15:40:58 INFO - 'sessionrestore', 15:40:58 INFO - 'sessionrestore_no_auto_restore', 15:40:58 INFO - 'tabpaint']}, 15:40:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['tsvgx', 15:40:58 INFO - 'tsvgr_opacity', 15:40:58 INFO - 'tart', 15:40:58 INFO - 'tscrollx', 15:40:58 INFO - 'cart']}, 15:40:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:40:58 INFO - 'tsvgr_opacity', 15:40:58 INFO - 'tart', 15:40:58 INFO - 'tscrollx', 15:40:58 INFO - 'cart']}, 15:40:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'talos_options': ['--disable-e10s'], 15:40:58 INFO - 'tests': ['tp5o']}, 15:40:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'tests': ['tp5o']}, 15:40:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'talos_options': ['--disable-e10s', 15:40:58 INFO - '--xperf_path', 15:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:58 INFO - 'tests': ['tp5n']}, 15:40:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:58 INFO - 'talos_options': ['--xperf_path', 15:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:58 INFO - 'tests': ['tp5n']}}, 15:40:58 INFO - 'talos.zip': {'path': '', 15:40:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:40:58 INFO - Running post-action listener: _resource_record_post_action 15:40:58 INFO - [mozharness: 2016-07-28 22:40:58.216684Z] Finished populate-webroot step (success) 15:40:58 INFO - [mozharness: 2016-07-28 22:40:58.216773Z] Running create-virtualenv step. 15:40:58 INFO - Running pre-action listener: _resource_record_pre_action 15:40:58 INFO - Running main action method: create_virtualenv 15:40:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:40:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:40:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:40:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:40:58 INFO - Using real prefix '/usr' 15:40:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:40:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:41:01 INFO - Installing pip.................done. 15:41:01 INFO - Return code: 0 15:41:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:01 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:41:01 INFO - Using env: {'DISPLAY': ':0', 15:41:01 INFO - 'HOME': '/home/cltbld', 15:41:01 INFO - 'LANG': 'en_US.UTF-8', 15:41:01 INFO - 'LANGUAGE': 'en_US:en', 15:41:01 INFO - 'LOGNAME': 'cltbld', 15:41:01 INFO - 'MAIL': '/var/mail/cltbld', 15:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:01 INFO - 'MOZ_NO_REMOTE': '1', 15:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:01 INFO - 'NO_EM_RESTART': '1', 15:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:01 INFO - 'PWD': '/builds/slave/test', 15:41:01 INFO - 'SHELL': '/bin/bash', 15:41:01 INFO - 'SHLVL': '1', 15:41:01 INFO - 'TERM': 'linux', 15:41:01 INFO - 'TMOUT': '86400', 15:41:01 INFO - 'USER': 'cltbld', 15:41:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:01 INFO - '_': '/tools/buildbot/bin/python'} 15:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:41:01 INFO - Cleaning up... 15:41:01 INFO - Return code: 0 15:41:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:01 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:41:01 INFO - Using env: {'DISPLAY': ':0', 15:41:01 INFO - 'HOME': '/home/cltbld', 15:41:01 INFO - 'LANG': 'en_US.UTF-8', 15:41:01 INFO - 'LANGUAGE': 'en_US:en', 15:41:01 INFO - 'LOGNAME': 'cltbld', 15:41:01 INFO - 'MAIL': '/var/mail/cltbld', 15:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:01 INFO - 'MOZ_NO_REMOTE': '1', 15:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:01 INFO - 'NO_EM_RESTART': '1', 15:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:01 INFO - 'PWD': '/builds/slave/test', 15:41:01 INFO - 'SHELL': '/bin/bash', 15:41:01 INFO - 'SHLVL': '1', 15:41:01 INFO - 'TERM': 'linux', 15:41:01 INFO - 'TMOUT': '86400', 15:41:01 INFO - 'USER': 'cltbld', 15:41:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:01 INFO - '_': '/tools/buildbot/bin/python'} 15:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:02 INFO - Downloading/unpacking psutil>=3.1.1 15:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:04 INFO - Installing collected packages: psutil 15:41:04 INFO - Running setup.py install for psutil 15:41:04 INFO - building 'psutil._psutil_linux' extension 15:41:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:41:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:41:06 INFO - building 'psutil._psutil_posix' extension 15:41:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:41:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:41:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:06 INFO - Successfully installed psutil 15:41:06 INFO - Cleaning up... 15:41:06 INFO - Return code: 0 15:41:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:06 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:41:06 INFO - Using env: {'DISPLAY': ':0', 15:41:06 INFO - 'HOME': '/home/cltbld', 15:41:06 INFO - 'LANG': 'en_US.UTF-8', 15:41:06 INFO - 'LANGUAGE': 'en_US:en', 15:41:06 INFO - 'LOGNAME': 'cltbld', 15:41:06 INFO - 'MAIL': '/var/mail/cltbld', 15:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:06 INFO - 'MOZ_NO_REMOTE': '1', 15:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:06 INFO - 'NO_EM_RESTART': '1', 15:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:06 INFO - 'PWD': '/builds/slave/test', 15:41:06 INFO - 'SHELL': '/bin/bash', 15:41:06 INFO - 'SHLVL': '1', 15:41:06 INFO - 'TERM': 'linux', 15:41:06 INFO - 'TMOUT': '86400', 15:41:06 INFO - 'USER': 'cltbld', 15:41:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:06 INFO - '_': '/tools/buildbot/bin/python'} 15:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:41:08 INFO - Installing collected packages: mozsystemmonitor 15:41:08 INFO - Running setup.py install for mozsystemmonitor 15:41:08 INFO - Successfully installed mozsystemmonitor 15:41:08 INFO - Cleaning up... 15:41:08 INFO - Return code: 0 15:41:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:08 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:41:08 INFO - Using env: {'DISPLAY': ':0', 15:41:08 INFO - 'HOME': '/home/cltbld', 15:41:08 INFO - 'LANG': 'en_US.UTF-8', 15:41:08 INFO - 'LANGUAGE': 'en_US:en', 15:41:08 INFO - 'LOGNAME': 'cltbld', 15:41:08 INFO - 'MAIL': '/var/mail/cltbld', 15:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:08 INFO - 'MOZ_NO_REMOTE': '1', 15:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:08 INFO - 'NO_EM_RESTART': '1', 15:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:08 INFO - 'PWD': '/builds/slave/test', 15:41:08 INFO - 'SHELL': '/bin/bash', 15:41:08 INFO - 'SHLVL': '1', 15:41:08 INFO - 'TERM': 'linux', 15:41:08 INFO - 'TMOUT': '86400', 15:41:08 INFO - 'USER': 'cltbld', 15:41:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:08 INFO - '_': '/tools/buildbot/bin/python'} 15:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:09 INFO - Downloading/unpacking jsonschema==2.5.1 15:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:41:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:41:11 INFO - warning: no files found matching '*.txt' 15:41:11 INFO - no previously-included directories found matching 'build' 15:41:11 INFO - no previously-included directories found matching 'dist' 15:41:11 INFO - no previously-included directories found matching '.git*' 15:41:11 INFO - Installing collected packages: jsonschema, functools32 15:41:11 INFO - Running setup.py install for functools32 15:41:11 INFO - warning: no files found matching '*.txt' 15:41:11 INFO - no previously-included directories found matching 'build' 15:41:11 INFO - no previously-included directories found matching 'dist' 15:41:11 INFO - no previously-included directories found matching '.git*' 15:41:11 INFO - Successfully installed jsonschema functools32 15:41:11 INFO - Cleaning up... 15:41:11 INFO - Return code: 0 15:41:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:11 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:41:11 INFO - Using env: {'DISPLAY': ':0', 15:41:11 INFO - 'HOME': '/home/cltbld', 15:41:11 INFO - 'LANG': 'en_US.UTF-8', 15:41:11 INFO - 'LANGUAGE': 'en_US:en', 15:41:11 INFO - 'LOGNAME': 'cltbld', 15:41:11 INFO - 'MAIL': '/var/mail/cltbld', 15:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:11 INFO - 'MOZ_NO_REMOTE': '1', 15:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:11 INFO - 'NO_EM_RESTART': '1', 15:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:11 INFO - 'PWD': '/builds/slave/test', 15:41:11 INFO - 'SHELL': '/bin/bash', 15:41:11 INFO - 'SHLVL': '1', 15:41:11 INFO - 'TERM': 'linux', 15:41:11 INFO - 'TMOUT': '86400', 15:41:11 INFO - 'USER': 'cltbld', 15:41:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:11 INFO - '_': '/tools/buildbot/bin/python'} 15:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:41:11 INFO - Cleaning up... 15:41:11 INFO - Return code: 0 15:41:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:11 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:41:11 INFO - Using env: {'DISPLAY': ':0', 15:41:11 INFO - 'HOME': '/home/cltbld', 15:41:11 INFO - 'LANG': 'en_US.UTF-8', 15:41:11 INFO - 'LANGUAGE': 'en_US:en', 15:41:11 INFO - 'LOGNAME': 'cltbld', 15:41:11 INFO - 'MAIL': '/var/mail/cltbld', 15:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:11 INFO - 'MOZ_NO_REMOTE': '1', 15:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:11 INFO - 'NO_EM_RESTART': '1', 15:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:11 INFO - 'PWD': '/builds/slave/test', 15:41:11 INFO - 'SHELL': '/bin/bash', 15:41:11 INFO - 'SHLVL': '1', 15:41:11 INFO - 'TERM': 'linux', 15:41:11 INFO - 'TMOUT': '86400', 15:41:11 INFO - 'USER': 'cltbld', 15:41:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:11 INFO - '_': '/tools/buildbot/bin/python'} 15:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:41:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:41:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:14 INFO - Downloading docopt-0.6.1.tar.gz 15:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:41:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:41:14 INFO - Running setup.py install for blobuploader 15:41:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:41:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:41:14 INFO - Running setup.py install for requests 15:41:15 INFO - Running setup.py install for docopt 15:41:15 INFO - Successfully installed blobuploader requests docopt 15:41:15 INFO - Cleaning up... 15:41:15 INFO - Return code: 0 15:41:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41: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')]} 15:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41: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')]} 15:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:15 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:15 INFO - Using env: {'DISPLAY': ':0', 15:41:15 INFO - 'HOME': '/home/cltbld', 15:41:15 INFO - 'LANG': 'en_US.UTF-8', 15:41:15 INFO - 'LANGUAGE': 'en_US:en', 15:41:15 INFO - 'LOGNAME': 'cltbld', 15:41:15 INFO - 'MAIL': '/var/mail/cltbld', 15:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:15 INFO - 'MOZ_NO_REMOTE': '1', 15:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:15 INFO - 'NO_EM_RESTART': '1', 15:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:15 INFO - 'PWD': '/builds/slave/test', 15:41:15 INFO - 'SHELL': '/bin/bash', 15:41:15 INFO - 'SHLVL': '1', 15:41:15 INFO - 'TERM': 'linux', 15:41:15 INFO - 'TMOUT': '86400', 15:41:15 INFO - 'USER': 'cltbld', 15:41:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:15 INFO - '_': '/tools/buildbot/bin/python'} 15:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:15 INFO - Running setup.py (path:/tmp/pip-T8aVYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:15 INFO - Running setup.py (path:/tmp/pip-6HYpFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:15 INFO - Running setup.py (path:/tmp/pip-fTPPUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:15 INFO - Running setup.py (path:/tmp/pip-xdoHnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:15 INFO - Running setup.py (path:/tmp/pip-GvMzSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:15 INFO - Running setup.py (path:/tmp/pip-XuYHUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:15 INFO - Running setup.py (path:/tmp/pip-6qB7IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:16 INFO - Running setup.py (path:/tmp/pip-uXfp8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:16 INFO - Running setup.py (path:/tmp/pip-W1t459-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:16 INFO - Running setup.py (path:/tmp/pip-gDvzLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:16 INFO - Running setup.py (path:/tmp/pip-js41SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:16 INFO - Running setup.py (path:/tmp/pip-3IlKp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:16 INFO - Running setup.py (path:/tmp/pip-paxD7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:16 INFO - Running setup.py (path:/tmp/pip-O1ASjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:16 INFO - Running setup.py (path:/tmp/pip-gZYBrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:16 INFO - Running setup.py (path:/tmp/pip-iOkSsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:16 INFO - Running setup.py (path:/tmp/pip-KmlOfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:41:16 INFO - Running setup.py install for manifestparser 15:41:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:41:16 INFO - Running setup.py install for mozcrash 15:41:16 INFO - Running setup.py install for mozdebug 15:41:17 INFO - Running setup.py install for mozdevice 15:41:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for mozfile 15:41:17 INFO - Running setup.py install for mozhttpd 15:41:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for mozinfo 15:41:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for mozInstall 15:41:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for mozleak 15:41:17 INFO - Running setup.py install for mozlog 15:41:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for moznetwork 15:41:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:41:17 INFO - Running setup.py install for mozprocess 15:41:17 INFO - Running setup.py install for mozprofile 15:41:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:41:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:41:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:41:18 INFO - Running setup.py install for mozrunner 15:41:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:41:18 INFO - Running setup.py install for mozscreenshot 15:41:18 INFO - Running setup.py install for moztest 15:41:18 INFO - Running setup.py install for mozversion 15:41:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:41:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:41:18 INFO - Cleaning up... 15:41:18 INFO - Return code: 0 15:41:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:18 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:18 INFO - Using env: {'DISPLAY': ':0', 15:41:18 INFO - 'HOME': '/home/cltbld', 15:41:18 INFO - 'LANG': 'en_US.UTF-8', 15:41:18 INFO - 'LANGUAGE': 'en_US:en', 15:41:18 INFO - 'LOGNAME': 'cltbld', 15:41:18 INFO - 'MAIL': '/var/mail/cltbld', 15:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:18 INFO - 'MOZ_NO_REMOTE': '1', 15:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:18 INFO - 'NO_EM_RESTART': '1', 15:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:18 INFO - 'PWD': '/builds/slave/test', 15:41:18 INFO - 'SHELL': '/bin/bash', 15:41:18 INFO - 'SHLVL': '1', 15:41:18 INFO - 'TERM': 'linux', 15:41:18 INFO - 'TMOUT': '86400', 15:41:18 INFO - 'USER': 'cltbld', 15:41:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:18 INFO - '_': '/tools/buildbot/bin/python'} 15:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:18 INFO - Running setup.py (path:/tmp/pip-ib6O5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:18 INFO - Running setup.py (path:/tmp/pip-cpihOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:18 INFO - Running setup.py (path:/tmp/pip-Y6gUwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:18 INFO - Running setup.py (path:/tmp/pip-ddQjHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:19 INFO - Running setup.py (path:/tmp/pip-DPPRv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:19 INFO - Running setup.py (path:/tmp/pip-aZVIfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:19 INFO - Running setup.py (path:/tmp/pip-mrUSG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:19 INFO - Running setup.py (path:/tmp/pip-Pq5236-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:19 INFO - Running setup.py (path:/tmp/pip-DpMDJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:19 INFO - Running setup.py (path:/tmp/pip-7d8zhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:19 INFO - Running setup.py (path:/tmp/pip-xsO8pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:19 INFO - Running setup.py (path:/tmp/pip-i7a4yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:19 INFO - Running setup.py (path:/tmp/pip-02fdeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:19 INFO - Running setup.py (path:/tmp/pip-uSw7kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:19 INFO - Running setup.py (path:/tmp/pip-bS0toK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:19 INFO - Running setup.py (path:/tmp/pip-Am_4_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:19 INFO - Running setup.py (path:/tmp/pip-exeukr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:21 INFO - Downloading blessings-1.6.tar.gz 15:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:41:21 INFO - Installing collected packages: blessings 15:41:21 INFO - Running setup.py install for blessings 15:41:22 INFO - Successfully installed blessings 15:41:22 INFO - Cleaning up... 15:41:22 INFO - Return code: 0 15:41:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:22 INFO - Reading from file tmpfile_stdout 15:41:22 INFO - Current package versions: 15:41:22 INFO - argparse == 1.2.1 15:41:22 INFO - blessings == 1.6 15:41:22 INFO - blobuploader == 1.2.4 15:41:22 INFO - docopt == 0.6.1 15:41:22 INFO - functools32 == 3.2.3-2 15:41:22 INFO - jsonschema == 2.5.1 15:41:22 INFO - manifestparser == 1.1 15:41:22 INFO - mozInstall == 1.12 15:41:22 INFO - mozcrash == 0.17 15:41:22 INFO - mozdebug == 0.1 15:41:22 INFO - mozdevice == 0.48 15:41:22 INFO - mozfile == 1.2 15:41:22 INFO - mozhttpd == 0.7 15:41:22 INFO - mozinfo == 0.9 15:41:22 INFO - mozleak == 0.1 15:41:22 INFO - mozlog == 3.3 15:41:22 INFO - moznetwork == 0.27 15:41:22 INFO - mozprocess == 0.23 15:41:22 INFO - mozprofile == 0.28 15:41:22 INFO - mozrunner == 6.12 15:41:22 INFO - mozscreenshot == 0.1 15:41:22 INFO - mozsystemmonitor == 0.3 15:41:22 INFO - moztest == 0.7 15:41:22 INFO - mozversion == 1.4 15:41:22 INFO - psutil == 3.1.1 15:41:22 INFO - requests == 1.2.3 15:41:22 INFO - wsgiref == 0.1.2 15:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:22 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 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:22 INFO - Using env: {'DISPLAY': ':0', 15:41:22 INFO - 'HOME': '/home/cltbld', 15:41:22 INFO - 'LANG': 'en_US.UTF-8', 15:41:22 INFO - 'LANGUAGE': 'en_US:en', 15:41:22 INFO - 'LOGNAME': 'cltbld', 15:41:22 INFO - 'MAIL': '/var/mail/cltbld', 15:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:22 INFO - 'MOZ_NO_REMOTE': '1', 15:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:22 INFO - 'NO_EM_RESTART': '1', 15:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:22 INFO - 'PWD': '/builds/slave/test', 15:41:22 INFO - 'SHELL': '/bin/bash', 15:41:22 INFO - 'SHLVL': '1', 15:41:22 INFO - 'TERM': 'linux', 15:41:22 INFO - 'TMOUT': '86400', 15:41:22 INFO - 'USER': 'cltbld', 15:41:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:22 INFO - '_': '/tools/buildbot/bin/python'} 15:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:41:22 INFO - Cleaning up... 15:41:22 INFO - Return code: 0 15:41:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:41:22 INFO - Using env: {'DISPLAY': ':0', 15:41:22 INFO - 'HOME': '/home/cltbld', 15:41:22 INFO - 'LANG': 'en_US.UTF-8', 15:41:22 INFO - 'LANGUAGE': 'en_US:en', 15:41:22 INFO - 'LOGNAME': 'cltbld', 15:41:22 INFO - 'MAIL': '/var/mail/cltbld', 15:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:22 INFO - 'MOZ_NO_REMOTE': '1', 15:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:22 INFO - 'NO_EM_RESTART': '1', 15:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:22 INFO - 'PWD': '/builds/slave/test', 15:41:22 INFO - 'SHELL': '/bin/bash', 15:41:22 INFO - 'SHLVL': '1', 15:41:22 INFO - 'TERM': 'linux', 15:41:22 INFO - 'TMOUT': '86400', 15:41:22 INFO - 'USER': 'cltbld', 15:41:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:22 INFO - '_': '/tools/buildbot/bin/python'} 15:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:41:22 INFO - Cleaning up... 15:41:22 INFO - Return code: 0 15:41:22 INFO - Running post-action listener: _resource_record_post_action 15:41:22 INFO - Running post-action listener: _start_resource_monitoring 15:41:22 INFO - Starting resource monitoring. 15:41:22 INFO - [mozharness: 2016-07-28 22:41:22.846365Z] Finished create-virtualenv step (success) 15:41:22 INFO - [mozharness: 2016-07-28 22:41:22.847312Z] Running install step. 15:41:22 INFO - Running pre-action listener: _resource_record_pre_action 15:41:22 INFO - Running main action method: install 15:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:23 INFO - Reading from file tmpfile_stdout 15:41:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:41:23 INFO - Reading from file tmpfile_stdout 15:41:23 INFO - Output received: 15:41:23 INFO - Usage: mozinstall [options] installer 15:41:23 INFO - Options: 15:41:23 INFO - -h, --help show this help message and exit 15:41:23 INFO - -d DEST, --destination=DEST 15:41:23 INFO - Directory to install application into. [default: 15:41:23 INFO - "/builds/slave/test"] 15:41:23 INFO - --app=APP Application being installed. [default: firefox] 15:41:23 INFO - mkdir: /builds/slave/test/build/application 15:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:41:39 INFO - Reading from file tmpfile_stdout 15:41:39 INFO - Output received: 15:41:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:41:39 INFO - Running post-action listener: _resource_record_post_action 15:41:39 INFO - [mozharness: 2016-07-28 22:41:39.536502Z] Finished install step (success) 15:41:39 INFO - [mozharness: 2016-07-28 22:41:39.536779Z] Running run-tests step. 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: run_tests 15:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:41:39 INFO - Python 2.7.3 15:41:39 INFO - Return code: 0 15:41:39 INFO - grabbing minidump binary from tooltool 15:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:39 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 0x138b3b0>, '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 0x138c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:41:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:41:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:41:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:41:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:41:39 INFO - Return code: 0 15:41:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:41:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:41:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:41:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:41:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:41:39 INFO - Using env: {'DISPLAY': ':0', 15:41:39 INFO - 'HOME': '/home/cltbld', 15:41:39 INFO - 'LANG': 'en_US.UTF-8', 15:41:39 INFO - 'LANGUAGE': 'en_US:en', 15:41:39 INFO - 'LOGNAME': 'cltbld', 15:41:39 INFO - 'MAIL': '/var/mail/cltbld', 15:41:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:41:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:39 INFO - 'MOZ_NO_REMOTE': '1', 15:41:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:39 INFO - 'NO_EM_RESTART': '1', 15:41:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:39 INFO - 'PWD': '/builds/slave/test', 15:41:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:41:39 INFO - 'SHELL': '/bin/bash', 15:41:39 INFO - 'SHLVL': '1', 15:41:39 INFO - 'TERM': 'linux', 15:41:39 INFO - 'TMOUT': '86400', 15:41:39 INFO - 'USER': 'cltbld', 15:41:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140', 15:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:39 INFO - '_': '/tools/buildbot/bin/python'} 15:41:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:41:39 INFO - mozversion application_buildid: 20160728141329 15:41:39 INFO - mozversion application_changeset: 8e0019ff663e368c44b63fe10453add7b9fb0782 15:41:39 INFO - mozversion application_display_name: Nightly 15:41:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:41:39 INFO - mozversion application_name: Firefox 15:41:39 INFO - mozversion application_remotingname: firefox 15:41:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:41:39 INFO - mozversion application_vendor: Mozilla 15:41:39 INFO - mozversion application_version: 50.0a1 15:41:39 INFO - mozversion platform_buildid: 20160728141329 15:41:39 INFO - mozversion platform_changeset: 8e0019ff663e368c44b63fe10453add7b9fb0782 15:41:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:41:39 INFO - mozversion platform_version: 50.0a1 15:41:39 INFO - using testdate: 1469745699 15:41:39 INFO - actual date: 1469745699 15:41:39 INFO - starting webserver on 'localhost:33723' 15:41:39 INFO - SUITE-START | Running 2 tests 15:41:39 INFO - TEST-START | dromaeo_css 15:41:39 INFO - operating with platform_type : linux_ 15:41:39 INFO - Initialising browser for dromaeo_css test... 15:41:39 INFO - TEST-INFO | started process 3300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwhq5A6/profile http://localhost:33723/getInfo.html) 15:41:44 INFO - PROCESS | 3300 | JavaScript error: , line 0: uncaught exception: undefined 15:41:47 INFO - PROCESS | 3300 | __metrics Screen width/height:1600/1200 15:41:47 INFO - PROCESS | 3300 | colorDepth:24 15:41:47 INFO - PROCESS | 3300 | Browser inner width/height: 1024/697 15:41:47 INFO - PROCESS | 3300 | __metrics 15:41:48 INFO - PROCESS | 3300 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:41:48 INFO - PROCESS | 3300 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:48 INFO - PROCESS | 3300 | console.error: PushService: 15:41:48 INFO - PROCESS | 3300 | stateChangeProcessEnqueue: Error transitioning state 15:41:48 INFO - PROCESS | 3300 | UnknownError 15:41:49 INFO - TEST-INFO | 3300: exit 0 15:41:49 INFO - Browser initialized. 15:41:49 INFO - Running cycle 1/1 for dromaeo_css test... 15:41:49 INFO - TEST-INFO | started process 3379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwhq5A6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:01 INFO - PROCESS | 3379 | RSS: Main: 159637504 15:42:01 INFO - PROCESS | 3379 | 15:42:52 INFO - PROCESS | 3379 | 1469745772702 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:45:04 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33723/tests/dromaeo/cssquery-ext.html) 15:45:05 INFO - PROCESS | 3379 | RSS: Main: 239288320 15:45:05 INFO - PROCESS | 3379 | 15:48:08 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-ext.html (next: http://localhost:33723/tests/dromaeo/cssquery-jquery.html) 15:48:08 INFO - PROCESS | 3379 | RSS: Main: 245977088 15:48:08 INFO - PROCESS | 3379 | 15:51:11 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33723/tests/dromaeo/cssquery-mootools.html) 15:51:11 INFO - PROCESS | 3379 | RSS: Main: 190726144 15:51:11 INFO - PROCESS | 3379 | 15:54:13 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33723/tests/dromaeo/cssquery-prototype.html) 15:54:14 INFO - PROCESS | 3379 | RSS: Main: 192229376 15:54:14 INFO - PROCESS | 3379 | 15:57:17 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33723/tests/dromaeo/cssquery-yui.html) 15:57:18 INFO - PROCESS | 3379 | RSS: Main: 191344640 15:57:18 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:33723/tests/dromaeo/cssquery-yui.html (next: http://localhost:33723/tests/dromaeo/cssquery-dojo.html) 16:00:21 INFO - PROCESS | 3379 | RSS: Main: 280121344 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | __start_tp_report 16:00:21 INFO - PROCESS | 3379 | _x_x_mozilla_page_load 16:00:21 INFO - PROCESS | 3379 | _x_x_mozilla_page_load_details 16:00:21 INFO - PROCESS | 3379 | |i|pagename|runs| 16:00:21 INFO - PROCESS | 3379 | |0;dojo.html;2592.403747138158;2599.2072417912555;2627.8817453214597;2632.8946842126315;2639.7624213820764;4583.679142460029;4652.883677908054;4694.2958556216545;4702.9294560581575;4721.291806229063;4710.811567537303;4718.386609740737;4744.4069491313585;4773.976130119353;4820.397450318701;4258.361245813122;4266.146770645868;4309.396684464177;4330.653547716175;4386.0569977455;4323.848665296715;4365.170617582649;4392.29723244281;4394.318880573516;4442.8667139985855;4199;4263.8081286342185;4349.217140914634;4354.129174165179;4413.646908247332;4251.9787401062795;4292.18448494785;4323.589259020388;4340.826366945318;4387.890302742425;4305.117450922585;4307.246231909403;4314.633256173198;4349.565043495657;4350.108227813291;4566.657500687462;4670.883227919295;4689.601383882374;4708.340832283483;4741.739204343759;4934.654574179809;4961.677490963112;4998.52514011172;5013.47358527353;5088.872778180576;5089.770960306795;5093.79624815007;5098.898022039575;5109.4379618241965;5116.386033675945;4699.647526435531;4713.528647135293;4750.049990002013;4753.952460475421;4754.02542478791;5026.924596131061;5082.695038297714;5130.7947682093045;5133.537981581676;5241.921371179359;4963.6277279204205;4996.300517927493;5006.424261209934;5011.599072074226;5024.598032157419;5000.1249781288125;5015.623828212899;5023.974880125649;5060.468650791688;5076.720780357042;4858.854234372974;4989.301497790312;5001.924971125436;5034.16936205522;5095.87260318495;5025.7989680412375;5032.245163225545;5037.949620503748;5041.6722913010535;5088.974555127201;4258.7657678827345;4288.356746488052;4289.892752681208;4303.806328715215;4346.239408103569;3662.468942003448;3687.410014397737;3725.981370093132;3739.3269211541638;3768.660820526166;4359.585839345257;4363.956360436418;4373.540778218305;4382.145481631052;4402.3836662867225;5072.163093089599;5107;5108.872278193075;5110.770015349318;5145;4202.789860506962;4274.743515389025;4320.3519472078815;4364.585364390377;4400.471943366816;4538.614217791459;4544.6818722689095;4584.908301833944;4588.2888152336445;4590.724556526619;4729.468071373907;4737.715737055788;4738.976305118453;4750.501197374226;4785.042991401733;4870.926936095891;5039.974800125976;5067.569256613082;5075.720835354091;5116.488351164854;4803.327534145153;4834.0331933612715;4840.564349208588;4857.271409288635;4880.292357608056;5052.115879720961;5065.746712664426;5065.7720402581235;5080.364954380702;5124.077666020152;4907.5828554571835;4980.800767969241;5128.512791284822;5143.948560514496;5147.974260128675;4883.145449546386;4955.876103097451;4960.20636698141;4990;5011.348524691767;4908.484609115992;4941.728204948762;4951.603871690184;4951.9752401237765;5002.2496625506465;4680.4149481314835;4811.879703007453;4863.8540843774745;4890.19311813561;4934.333864928189;4942.332785073969;4992.80028798844;4994;5022.27177059317;5039;4784.378030855966;4811.206150985048;4817.879553011203;4823.27650852375;4879.39007624047 16:00:21 INFO - PROCESS | 3379 | |1;ext.html;576.8096528145712;594.8430303060547;609.4454046817392;611.431368826991;624.0825985800874;38226.80886595567;39779.40330895039;39796.801015994955;43970.12059758803;44002.33996490055;39878.800605997;40370.394444083366;40419.191616167656;40551;40603.59396406043;7518.962405187966;7634.885476717854;7661.310482056614;7664.041994750656;7664.693412263503;7624.123225829017;7714.228577142297;7729.884051739228;7730.4975176613625;7732.729354472594;7722.111957124918;7724.111727151365;7734.690612375498;7741;7750.379969602446;7706.576138312391;7717.459777815555;7735.72924947627;7735.922640773577;7737.381009519225;7713.34436572892;7753.418493613001;7764.495307804975;7776.611169441562;7782.182870798598;37902.43146352807;38271.42592861109;38296.42555361644;38326.23347533034;38434.423483647486;2939.1770304314828;2990.8654110565076;3045.512717965115;3231.74146068314;3725.0873535983587;29093;29220.561691574643;29750.851245743634;29880.40239195204;30085.699143008507;3084.90745277642;3102.1934297082694;3105.627324721025;3108.8445577721022;3113.8910138145056;174640.12679936647;175415;175671;176178;176207;51800.74099629478;52085.218721719204;52208.73895630497;52255.477445225064;52302.47697523052;32879.83560082184;33696.32607347839;33823;35476;54209;15316;15493.380264789508;15534.766978495332;15536.145511996723;15568.922155389151;11747.941260293816;11941.462634181482;11941.940290298493;11948.402579870972;11950.940245298892;18171.818281817013;18205.817941820413;18397.448076557725;18418.079096045145;18500.629987400178;6726.7981960541265;6797.694103765342;6799.796006119825;6903.620300883399;6921.93078069223;727.6325455644866;875.4047247871508;877.5436772878068;921.3964853021282;936.8266870628955;27867.860660696566;27956.30109247285;28114.987318308158;28552.71447285542;28883.71116288852;868.9000764912116;920.9585568649427;968.5689868008809;969.8496733006396;969.9612015519441;14467.710645787025;15186.696266074616;15211.923940380228;15321.923390382977;15371.308291126927;399998;403565;404188;404482;407230;49330.013399732525;49678;49711.75144124256;49739.25391119136;49793;1062.8033813744482;1132.4960392625203;1148.3913525831156;1166.2302880099264;1196.3360335013977;26936.498255226696;29003.41993160167;29197.708022919498;29288.414231715673;29775.25561860884;41323.58676413318;41849.79075104605;41933;41948.37077443902;41963.37054944239;300293;301272;301501;302602;302653;21939.122435102418;22452.438689032904;22550.097996079974;22635.773642264026;25450.363740906625;41253.38119928264;41430.792846035576;41572.3764143532;41627.7918610405;42003;34528.48207276843;35805.46291805573;35812.462813057304;35884.461733074546;35955;35032;35049.47425788564;35260;35539.289214216085;35765.28469430649;32270.35459290848;32411;34107;34138.65861341355;35703;30363.696363036972;32441;32474.67525324811;32549.34901302008;32626.184345391554;24603.015879364626;24714.59824980097;24969.37576560528;25306.36734081589;25360.873195633903 16:00:21 INFO - PROCESS | 3379 | |2;jquery.html;334.50493269960475;341.603739661992;356.86260789596014;358.92642008388276;368.1771241275748;12801.231926084442;13362.465501379957;13819;16795.748063779054;16893.324267029337;16698.248578813953;16710.415135470263;16903.492895213134;16957.83042169578;17086.572835679115;4983.551480366776;5052.115879721034;5276.973615131919;5312.840614781543;5388.380336261341;3463.7402194835363;5394.433584473632;5430.402655707869;5431.21247419124;5432.456754324556;4435.556444355571;5820.941790582104;5862.267216597926;5917.585768996172;5934.851628709273;5039.647224694273;5907.350191478934;5914.88170236595;5915.201447804534;5920.822375328747;5124.128898087297;5213.947860521384;5216.7913283468615;5218.712970786605;5220.190870415092;12171.026317894548;12325.075619328496;18242.817571824246;20505.8974705127;20623.69064464034;1771.1941066814568;1835.4218421197281;1892.1485331600834;2064.4735592423835;2136.3484137338105;9142.725718228463;9533.142017218484;10136.341137826017;11678.6496405108;13152.736945261042;1721.712766221827;1723.3451288510412;1731.333436626895;1748.7551742756025;1789.910504474771;70028.64985675039;70255.64872175606;70354.64822675905;71155.2884471159;71768;9487;9531.714048578553;9643.951780241194;9714.271429642806;9946.602135914627;13371.866281337258;13392.866071339356;13411.195328280335;13422.127561708458;13430.798538021938;6898.206706228848;6937.410320122846;6957.199922009034;7038.612876291853;7104.21853596104;6605.735770569124;6691.832704182337;6735.730570777212;6757.8648427031185;6804.013418054355;4154.293770059097;4164.104717485755;4171.812268447927;4208.368744688321;4264.509581398117;1691.1628743771666;1769.646070785848;1772.299941523091;1796.8203179681927;1804.8736588438683;767.3784234769854;773.7117699031163;816.8978877640295;848.4061157189992;920.4799288402031;16461.58846028859;16628.58428539296;16681.83318166803;17084;17469.21388537519;816.1475642629049;832.4040146566894;838.3000194837257;841.2260720137489;880.5509190312858;8995.955020224988;9774.853377199348;9803.558839852081;9827.950860245654;9860.704178874645;380807;381575;384074;399689;402024;78123.60938195273;79888;81315.59342203251;81348;81809;850.1583432401877;880.1462581296132;881.0176653031951;881.4050515901869;881.7398867334152;14999.850001499844;15165.696686066438;15348.693026139637;15421.768673469682;15530.611734706723;25728.356791080372;26018.479630406906;36777.264454711294;37853.04804602222;37974;52156.47843521668;52339.47660523498;52635.73682131718;54401;54977.72511137419;7516.661750221144;7650.426218033558;7729.111152217567;7849.3328067114935;7858.371330293677;8964;10969.670909872717;11040.5031773572;11395.487203075716;12342.876571234172;9910.702678919644;10176.236782241214;10181.898181018096;10273.486325683836;10568.84146737815;9549.47477888695;9592.808143837225;9849.852252216078;10232.693019209435;10286.251337272832;9838.803223935623;10022.849657255292;10193.541290642088;10475.319104258198;10850.67447976562;6723.5293529452465;6829.282925292773;6900.30996900326;7021.192562855337;7825.334846538108;8356.415050946376;10225.43760093202;10446.268761186948;10452.372857628567;10852.18608604342 16:00:21 INFO - PROCESS | 3379 | |3;mootools.html;1170.444039081436;1286.2604002698447;1346.9663258418539;1366.7881478370853;1637.6560922206343;6510.283868774431;7425.66584503698;7656.157822639505;7657.999999999993;7809.531428114317;7656.846863062736;7715;7715.15133335334;7718.8456230875345;7735.1491335953;2149.118861266877;2174.7825217478203;2176.075168053571;2176.1730542393866;2177.1835561664375;2136.7756385579523;2171.695962565242;2210.5799898019327;2212.2036067015943;2213.734351877769;2168.7505936817233;2175.282156888231;2183.366823621148;2183.8143757780526;2214.202886960693;2088.1751708075303;2093.5498867743354;2094.413564202026;2094.790520947901;2097.538541520863;2035.2266138867283;2093.8638988465855;2106.441792924876;2116.8412369072225;2122.2253877334815;7561.357284630813;7600.923990760077;7664.156942736295;7665.233476652346;7725.806854828675;4548.727076375428;4709.740964246965;4721.433427988629;4722.677650257933;4728.456227533843;2732.4671689020647;2839.872205750746;2870.1389583125188;2870.6842247352774;2876.798624096314;850.817074329016;854.9691344184879;865.1694373401542;871.7036207689416;877.6006916852816;10455.424951627658;10558.52486638103;10585.100266477359;10591.788164236672;10603.469826508644;3821.8280177392085;3991.3015222335976;4132.235536425771;4140.3168477201525;4174.3321068628875;7964.761057168294;8016.31861291785;8042.437029408003;8049.275565199043;8053.15441878606;4623.9075218495445;4635.559621835921;4641.419822522184;4647.55848194421;4647.930281045787;3714.0529165063276;4091.85678501251;4249.97875010623;4295.935560966525;4302.462192225972;3294.472884338494;3343.8996830095134;3459.930801383958;3460.2387474755515;3488;998.9750256243507;1008.1632245236436;1013.9847902281472;1040.6877936618985;1044.8014877173314;850.6384786465727;852.7612268564811;866.2939704141105;903.6069309850236;904.8418024928103;5332.546733527616;5409.0263752524925;5472.2338872557875;5611.663300202001;5756.42435756421;830.2195935820309;841.3437518735396;852.3436953545735;885.968991085309;894.8970868350093;3690.557133143986;3769.8680546180753;3786.8674596388996;3826.712996525216;3842.5773164951834;9193.264538836876;9433.858492122623;9520.143187113194;9527.809443811086;9571.138597526256;9423.952880235693;9426.575804088832;9437.103475169848;9446.433214007182;9449.716508504756;7068.3991860691385;7192.280771922766;7218.494705370574;7220.638968051577;7220.675069621774;5380.704061276668;5423.430539793265;5555.638883472561;5559.19391688211;5715.657060576379;8848.734537963872;9015.413998090104;9041.638334466548;9048.547572621474;9055.320850936338;8785.780355491164;9045.321600880092;9089.681861134828;9147.817043659223;9172.633094676139;5948.078047902582;6380.425761681471;6520.347965203442;6638.137042184679;6643.60138391698;7472.065991751031;7644.770656880302;7651.196624354363;7727.11138219112;7730.420218483524;6566.6388348641285;6570.474362050929;6600.735970561123;6661.833454163685;6866.004429357815;6542.182227221598;6698.598084114774;6771.762988295386;6811;6896.379325860697;6020.4280593343565;6404.815109204812;6424.871502569829;6434.871302573829;6448.677566121582;4353.194658988097;4461.13007963444;4481.641468682563;4572.657050721143;4584.243599806128;4607.677462577587;4753.168195565831;4767.284907263938;4826.710397376169;4963.379577552806 16:00:21 INFO - PROCESS | 3379 | |4;prototype.html;284.60724200603164;291.1150103684798;298.6088224426003;299.87255416448005;301.8354996526895;4810.759462026897;4861.690696918961;4865.124277630025;4873.463918968911;4888.804447822083;4567.931481027787;4672.275797251432;4695.530446955311;4716.7405792681475;4825.951740482594;3701.463287823264;3730.3772858806437;3748.5876553579083;3797.9810100949458;3800.4109363048633;3818.9427158592644;3821.331267028273;3835.673967712748;3851.73037887348;3856.575776664579;3545.556805399325;3726.3665176919853;3769.453429252757;3803.3914573668217;3805.429185622165;3741.27045226181;3750.474933509311;3751.831167597451;3767.303048935928;3768.868089616864;3270.394976929276;3281.704646581819;3282.0810173151317;3296.719778818803;3305.6529064448127;4716.976415117902;4721.639180409795;4721.795942034759;4744.3595114659765;4760.310089918098;4090.713650044498;4231.661467082626;4256.1487702459635;4272.060146767706;4315.158544083905;5036.445990940993;5038.370203724535;5064.898702025976;5066.240063990431;5084.771185296633;3562;3571.357155711971;3574.303010912873;3575.606683264839;3603.6036036036016;5183.896322073575;5233.639253794003;5297.49673780994;5314.176302673091;5341.866453338659;3644.599094099647;3651.580068292127;3655.524781778352;3656.7018708358682;3665.578458477256;3695.3902606069696;3705.7220708446434;3706.4069748840056;3710.7216958728204;3715.3126671565847;4241.1941731071;4284.121755040209;4293;4293.570642935744;4294.677899157576;4922.286268491049;5040.747962601855;5044.924326135111;5084.593232541388;5092.26162206478;1267.993660031694;1284.7751643462357;1291.5673249461347;1293.5149319005372;1296.0992110483123;822.2763967708378;834.1283358889974;854.7605971341579;877.7015814623059;880.5025160784137;4425.690201685916;4445.866624001285;4462.174497717932;4477;4501.68488205829;5182.663126896739;5204.713740744295;5219.947800521946;5237.711925844115;5243.23973023917;4331.263685173528;4384.583464570861;4460.197164510354;4482.6327969968825;4484.439445069366;2750.339918419565;2750.5324094903913;2755.820871643377;2757.6277202577394;2764.3641962348775;4849.248366503198;4864.467692676795;4874.317595536628;4892.2661600760175;4895.167821470359;5050.974745126251;5298;5321.840344789663;5359.598030147755;5367.141257398797;4920.532549407801;4934.5805606523845;4944.491929961325;4979.427365852901;4987.10232158215;5245.89508209826;5301.973490132525;5318.7340632967425;5338.866528336667;5338.866528336823;4882.975585122052;5142.434332223377;5185.896282074413;5187.651210685173;5246.947530524799;4933.728644924564;4969.329140566122;4988.176950803077;5002.574781143643;5003.399592048978;3836.5779764225354;3844.94232586517;3858.5176852893387;3866.149447121629;3882.3400021995762;5092.898142037213;5188.533032027136;5203.375594928632;5210.296609957607;5294.808668049658;5032.3206367139965;5041.218611115283;5042.924356134734;5043.5460808527405;5071.239314102914;5075.974620126875;5078.441371449064;5090.770915308746;5095.92356114666;5099.464556221544;4876.902461950812;4893.039472045823;4946.579540739078;4948.183549714401;4966.230234313687;4854.320395144612;4927.236278376858;5036.395632524121;5078.492150784892;5097.343363406833;4929.408470983361;4942.505749425029;4946.208606622923;4949.950500494949;4970.8260210893895 16:00:21 INFO - PROCESS | 3379 | |5;yui.html;611.5810669691265;613.4111253196932;634.8761991411674;709.9964500177498;735.5219107580073;12414.937925310383;13633.045686801928;13699;13708.108972916754;13709.794353084711;12827;12981.221126732402;12981.805272920914;13001.934990325035;13018.674533136676;630.7224821078734;642.3063091860779;743.2233316184573;754.0875540595858;768.4006474949521;765.8123759678887;783.5181363461487;783.9725609603665;784.231453175888;784.2980532423478;836.2682652678906;837.9832403351929;838.1283465196188;838.1534650003509;838.6184286149818;670.47367816264;794.5351969098084;819.3690858039276;833.7790485521372;833.791552111972;598.0282041682266;601.5247954116243;603.0983679399283;603.1194456094108;603.7584966013586;12778.10553261272;12785.61643150707;12820.551280705224;12835.486580536768;12844.422001009976;12277;12412.441440135215;12615.936920315431;12810.359482025955;13024.804627930589;11122.221444498888;11276.605318813803;11538.192326537146;11612;12026.098042646836;4009.1981603679087;4074.164796216798;4076.103257283393;4169.061961058768;4175.039740859589;60694.696526517524;62806.68596657033;63317.366826332065;63710.68144659247;63821.68089159571;10168.949155254177;10352;10455.84316235257;10503.159747220205;10504.159667226604;18763.81236187648;18782.530436738918;18794.436166915013;18796.81203187978;18805.34181303675;6709.664516774142;6788.932110678928;6891.173059232924;7056.259092795285;7112.537685050455;3731.1231860512758;3736.143014081683;3841.4429907663234;3847.96152038476;3872.1481274119647;2774.3480282133683;2805.410863718601;2807.4244779820087;2854.628898243215;2858.0139851751114;492.38206051405257;493.8691246819596;497.16228155558;502.86171302891995;506.96958182509167;511.5699236618464;546.7594258526236;548.6625725179066;550.0896017091719;561.9550435965112;7877.761288743036;8077.434579579491;8189.590520473953;8662.87005694915;8728.607212675444;590.5688847141611;616.8149555133532;619.331122387829;623.4856243599049;642.4121928435522;3872.6514613684903;3945.2306800174265;4118.608732170499;4137.213929353474;4158.313878210061;92897;95750;96293.0370696298;96614;99540;73134.26865731274;73936;83122;85192;87502;79358;80678.19321806825;80704;81001.59499202466;81181;8259.95870020646;9039.45763254207;9052.366334356531;9091.181793638605;9205.677801277192;42028.57971420247;47597.28604070872;48596.27105593348;48946.75526622344;49969.25046124238;64992.52585952487;73779.63110184629;73946;74129;75616.24383756092;11307.830382544433;11493.310401375944;11961.521539138685;11978.820317695416;12078.094142939139;13572.86427135716;13652.843307673205;13681.726365472436;14010.369533371226;14025.579232623038;11431.542738290707;11829.585964491545;11984.64046078619;12106.213096148722;12204.389780511117;11606.419679016184;11900.40497975115;12011.339376334385;12142.575009874612;12539.811902821648;11280.605178818701;11598.594049208237;11654.125940554322;12039.939800300943;12123.090768192244;9765.85351219718;9912.207023437963;10132.544035518273;10399.168066554506;10485.266031378036;9572.282078844253;9888.703338899844;9955.950220248853;10083.798324033625;10099.394036357842 16:00:21 INFO - PROCESS | 3379 | __end_tp_report 16:00:21 INFO - PROCESS | 3379 | __start_cc_report 16:00:21 INFO - PROCESS | 3379 | _x_x_mozilla_cycle_collect,991 16:00:21 INFO - PROCESS | 3379 | __end_cc_report 16:00:21 INFO - PROCESS | 3379 | __startTimestamp1469746821636__endTimestamp 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | ------- Summary: start ------- 16:00:21 INFO - PROCESS | 3379 | Number of tests: 6 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#0] dojo.html Cycles:165 Average:4670.41 Median:4811.21 stddev:498.13 (10.4%) stddev-sans-first:472.23 16:00:21 INFO - PROCESS | 3379 | Values: 2592.4 2599.2 2627.9 2632.9 2639.8 4583.7 4652.9 4694.3 4702.9 4721.3 4710.8 4718.4 4744.4 4774.0 4820.4 4258.4 4266.1 4309.4 4330.7 4386.1 4323.8 4365.2 4392.3 4394.3 4442.9 4199.0 4263.8 4349.2 4354.1 4413.6 4252.0 4292.2 4323.6 4340.8 4387.9 4305.1 4307.2 4314.6 4349.6 4350.1 4566.7 4670.9 4689.6 4708.3 4741.7 4934.7 4961.7 4998.5 5013.5 5088.9 5089.8 5093.8 5098.9 5109.4 5116.4 4699.6 4713.5 4750.0 4754.0 4754.0 5026.9 5082.7 5130.8 5133.5 5241.9 4963.6 4996.3 5006.4 5011.6 5024.6 5000.1 5015.6 5024.0 5060.5 5076.7 4858.9 4989.3 5001.9 5034.2 5095.9 5025.8 5032.2 5037.9 5041.7 5089.0 4258.8 4288.4 4289.9 4303.8 4346.2 3662.5 3687.4 3726.0 3739.3 3768.7 4359.6 4364.0 4373.5 4382.1 4402.4 5072.2 5107.0 5108.9 5110.8 5145.0 4202.8 4274.7 4320.4 4364.6 4400.5 4538.6 4544.7 4584.9 4588.3 4590.7 4729.5 4737.7 4739.0 4750.5 4785.0 4870.9 5040.0 5067.6 5075.7 5116.5 4803.3 4834.0 4840.6 4857.3 4880.3 5052.1 5065.7 5065.8 5080.4 5124.1 4907.6 4980.8 5128.5 5143.9 5148.0 4883.1 4955.9 4960.2 4990.0 5011.3 4908.5 4941.7 4951.6 4952.0 5002.2 4680.4 4811.9 4863.9 4890.2 4934.3 4942.3 4992.8 4994.0 5022.3 5039.0 4784.4 4811.2 4817.9 4823.3 4879.4 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#1] ext.html Cycles:180 Average:44768.26 Median:35848.46 stddev:81442.10 (227.2%) stddev-sans-first:81602.98 16:00:21 INFO - PROCESS | 3379 | Values: 576.8 594.8 609.4 611.4 624.1 38226.8 39779.4 39796.8 43970.1 44002.3 39878.8 40370.4 40419.2 40551.0 40603.6 7519.0 7634.9 7661.3 7664.0 7664.7 7624.1 7714.2 7729.9 7730.5 7732.7 7722.1 7724.1 7734.7 7741.0 7750.4 7706.6 7717.5 7735.7 7735.9 7737.4 7713.3 7753.4 7764.5 7776.6 7782.2 37902.4 38271.4 38296.4 38326.2 38434.4 2939.2 2990.9 3045.5 3231.7 3725.1 29093.0 29220.6 29750.9 29880.4 30085.7 3084.9 3102.2 3105.6 3108.8 3113.9 174640.1 175415.0 175671.0 176178.0 176207.0 51800.7 52085.2 52208.7 52255.5 52302.5 32879.8 33696.3 33823.0 35476.0 54209.0 15316.0 15493.4 15534.8 15536.1 15568.9 11747.9 11941.5 11941.9 11948.4 11950.9 18171.8 18205.8 18397.4 18418.1 18500.6 6726.8 6797.7 6799.8 6903.6 6921.9 727.6 875.4 877.5 921.4 936.8 27867.9 27956.3 28115.0 28552.7 28883.7 868.9 921.0 968.6 969.8 970.0 14467.7 15186.7 15211.9 15321.9 15371.3 399998.0 403565.0 404188.0 404482.0 407230.0 49330.0 49678.0 49711.8 49739.3 49793.0 1062.8 1132.5 1148.4 1166.2 1196.3 26936.5 29003.4 29197.7 29288.4 29775.3 41323.6 41849.8 41933.0 41948.4 41963.4 300293.0 301272.0 301501.0 302602.0 302653.0 21939.1 22452.4 22550.1 22635.8 25450.4 41253.4 41430.8 41572.4 41627.8 42003.0 34528.5 35805.5 35812.5 35884.5 35955.0 35032.0 35049.5 35260.0 35539.3 35765.3 32270.4 32411.0 34107.0 34138.7 35703.0 30363.7 32441.0 32474.7 32549.3 32626.2 24603.0 24714.6 24969.4 25306.4 25360.9 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#2] jquery.html Cycles:180 Average:24172.33 Median:5088.12 stddev:64517.05 (1268.0%) stddev-sans-first:64673.21 16:00:21 INFO - PROCESS | 3379 | Values: 334.5 341.6 356.9 358.9 368.2 12801.2 13362.5 13819.0 16795.7 16893.3 16698.2 16710.4 16903.5 16957.8 17086.6 4983.6 5052.1 5277.0 5312.8 5388.4 3463.7 5394.4 5430.4 5431.2 5432.5 4435.6 5820.9 5862.3 5917.6 5934.9 5039.6 5907.4 5914.9 5915.2 5920.8 5124.1 5213.9 5216.8 5218.7 5220.2 12171.0 12325.1 18242.8 20505.9 20623.7 1771.2 1835.4 1892.1 2064.5 2136.3 9142.7 9533.1 10136.3 11678.6 13152.7 1721.7 1723.3 1731.3 1748.8 1789.9 70028.6 70255.6 70354.6 71155.3 71768.0 9487.0 9531.7 9644.0 9714.3 9946.6 13371.9 13392.9 13411.2 13422.1 13430.8 6898.2 6937.4 6957.2 7038.6 7104.2 6605.7 6691.8 6735.7 6757.9 6804.0 4154.3 4164.1 4171.8 4208.4 4264.5 1691.2 1769.6 1772.3 1796.8 1804.9 767.4 773.7 816.9 848.4 920.5 16461.6 16628.6 16681.8 17084.0 17469.2 816.1 832.4 838.3 841.2 880.6 8996.0 9774.9 9803.6 9828.0 9860.7 380807.0 381575.0 384074.0 399689.0 402024.0 78123.6 79888.0 81315.6 81348.0 81809.0 850.2 880.1 881.0 881.4 881.7 14999.9 15165.7 15348.7 15421.8 15530.6 25728.4 26018.5 36777.3 37853.0 37974.0 52156.5 52339.5 52635.7 54401.0 54977.7 7516.7 7650.4 7729.1 7849.3 7858.4 8964.0 10969.7 11040.5 11395.5 12342.9 9910.7 10176.2 10181.9 10273.5 10568.8 9549.5 9592.8 9849.9 10232.7 10286.3 9838.8 10022.8 10193.5 10475.3 10850.7 6723.5 6829.3 6900.3 7021.2 7825.3 8356.4 10225.4 10446.3 10452.4 10852.2 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#3] mootools.html Cycles:180 Average:5079.35 Median:5585.43 stddev:2827.73 (50.6%) stddev-sans-first:2820.40 16:00:21 INFO - PROCESS | 3379 | Values: 1170.4 1286.3 1347.0 1366.8 1637.7 6510.3 7425.7 7656.2 7658.0 7809.5 7656.8 7715.0 7715.2 7718.8 7735.1 2149.1 2174.8 2176.1 2176.2 2177.2 2136.8 2171.7 2210.6 2212.2 2213.7 2168.8 2175.3 2183.4 2183.8 2214.2 2088.2 2093.5 2094.4 2094.8 2097.5 2035.2 2093.9 2106.4 2116.8 2122.2 7561.4 7600.9 7664.2 7665.2 7725.8 4548.7 4709.7 4721.4 4722.7 4728.5 2732.5 2839.9 2870.1 2870.7 2876.8 850.8 855.0 865.2 871.7 877.6 10455.4 10558.5 10585.1 10591.8 10603.5 3821.8 3991.3 4132.2 4140.3 4174.3 7964.8 8016.3 8042.4 8049.3 8053.2 4623.9 4635.6 4641.4 4647.6 4647.9 3714.1 4091.9 4250.0 4295.9 4302.5 3294.5 3343.9 3459.9 3460.2 3488.0 999.0 1008.2 1014.0 1040.7 1044.8 850.6 852.8 866.3 903.6 904.8 5332.5 5409.0 5472.2 5611.7 5756.4 830.2 841.3 852.3 886.0 894.9 3690.6 3769.9 3786.9 3826.7 3842.6 9193.3 9433.9 9520.1 9527.8 9571.1 9424.0 9426.6 9437.1 9446.4 9449.7 7068.4 7192.3 7218.5 7220.6 7220.7 5380.7 5423.4 5555.6 5559.2 5715.7 8848.7 9015.4 9041.6 9048.5 9055.3 8785.8 9045.3 9089.7 9147.8 9172.6 5948.1 6380.4 6520.3 6638.1 6643.6 7472.1 7644.8 7651.2 7727.1 7730.4 6566.6 6570.5 6600.7 6661.8 6866.0 6542.2 6698.6 6771.8 6811.0 6896.4 6020.4 6404.8 6424.9 6434.9 6448.7 4353.2 4461.1 4481.6 4572.7 4584.2 4607.7 4753.2 4767.3 4826.7 4963.4 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#4] prototype.html Cycles:180 Average:4204.60 Median:4837.60 stddev:1223.18 (25.3%) stddev-sans-first:1190.70 16:00:21 INFO - PROCESS | 3379 | Values: 284.6 291.1 298.6 299.9 301.8 4810.8 4861.7 4865.1 4873.5 4888.8 4567.9 4672.3 4695.5 4716.7 4826.0 3701.5 3730.4 3748.6 3798.0 3800.4 3818.9 3821.3 3835.7 3851.7 3856.6 3545.6 3726.4 3769.5 3803.4 3805.4 3741.3 3750.5 3751.8 3767.3 3768.9 3270.4 3281.7 3282.1 3296.7 3305.7 4717.0 4721.6 4721.8 4744.4 4760.3 4090.7 4231.7 4256.1 4272.1 4315.2 5036.4 5038.4 5064.9 5066.2 5084.8 3562.0 3571.4 3574.3 3575.6 3603.6 5183.9 5233.6 5297.5 5314.2 5341.9 3644.6 3651.6 3655.5 3656.7 3665.6 3695.4 3705.7 3706.4 3710.7 3715.3 4241.2 4284.1 4293.0 4293.6 4294.7 4922.3 5040.7 5044.9 5084.6 5092.3 1268.0 1284.8 1291.6 1293.5 1296.1 822.3 834.1 854.8 877.7 880.5 4425.7 4445.9 4462.2 4477.0 4501.7 5182.7 5204.7 5219.9 5237.7 5243.2 4331.3 4384.6 4460.2 4482.6 4484.4 2750.3 2750.5 2755.8 2757.6 2764.4 4849.2 4864.5 4874.3 4892.3 4895.2 5051.0 5298.0 5321.8 5359.6 5367.1 4920.5 4934.6 4944.5 4979.4 4987.1 5245.9 5302.0 5318.7 5338.9 5338.9 4883.0 5142.4 5185.9 5187.7 5246.9 4933.7 4969.3 4988.2 5002.6 5003.4 3836.6 3844.9 3858.5 3866.1 3882.3 5092.9 5188.5 5203.4 5210.3 5294.8 5032.3 5041.2 5042.9 5043.5 5071.2 5076.0 5078.4 5090.8 5095.9 5099.5 4876.9 4893.0 4946.6 4948.2 4966.2 4854.3 4927.2 5036.4 5078.5 5097.3 4929.4 4942.5 4946.2 4950.0 4970.8 16:00:21 INFO - PROCESS | 3379 | 16:00:21 INFO - PROCESS | 3379 | [#5] yui.html Cycles:180 Average:18304.77 Median:495.52 stddev:25989.29 (5244.9%) stddev-sans-first:26028.24 16:00:21 INFO - PROCESS | 3379 | Values: 611.6 613.4 634.9 710.0 735.5 12414.9 13633.0 13699.0 13708.1 13709.8 12827.0 12981.2 12981.8 13001.9 13018.7 630.7 642.3 743.2 754.1 768.4 765.8 783.5 784.0 784.2 784.3 836.3 838.0 838.1 838.2 838.6 670.5 794.5 819.4 833.8 833.8 598.0 601.5 603.1 603.1 603.8 12778.1 12785.6 12820.6 12835.5 12844.4 12277.0 12412.4 12615.9 12810.4 13024.8 11122.2 11276.6 11538.2 11612.0 12026.1 4009.2 4074.2 4076.1 4169.1 4175.0 60694.7 62806.7 63317.4 63710.7 63821.7 10168.9 10352.0 10455.8 10503.2 10504.2 18763.8 18782.5 18794.4 18796.8 18805.3 6709.7 6788.9 6891.2 7056.3 7112.5 3731.1 3736.1 3841.4 3848.0 3872.1 2774.3 2805.4 2807.4 2854.6 2858.0 492.4 493.9 497.2 502.9 507.0 511.6 546.8 548.7 550.1 562.0 7877.8 8077.4 8189.6 8662.9 8728.6 590.6 616.8 619.3 623.5 642.4 3872.7 3945.2 4118.6 4137.2 4158.3 92897.0 95750.0 96293.0 96614.0 99540.0 73134.3 73936.0 83122.0 85192.0 87502.0 79358.0 80678.2 80704.0 81001.6 81181.0 8260.0 9039.5 9052.4 9091.2 9205.7 42028.6 47597.3 48596.3 48946.8 49969.3 64992.5 73779.6 73946.0 74129.0 75616.2 11307.8 11493.3 11961.5 11978.8 12078.1 13572.9 13652.8 13681.7 14010.4 14025.6 11431.5 11829.6 11984.6 12106.2 12204.4 11606.4 11900.4 12011.3 12142.6 12539.8 11280.6 11598.6 11654.1 12039.9 12123.1 9765.9 9912.2 10132.5 10399.2 10485.3 9572.3 9888.7 9956.0 10083.8 10099.4 16:00:21 INFO - PROCESS | 3379 | -------- Summary: end -------- 16:00:21 INFO - PROCESS | 3379 | 16:00:22 INFO - TEST-INFO | 3379: exit 0 16:00:22 INFO - TEST-OK | dromaeo_css | took 1122501ms 16:00:22 INFO - TEST-START | kraken 16:00:22 INFO - operating with platform_type : linux_ 16:00:22 INFO - Initialising browser for kraken test... 16:00:22 INFO - TEST-INFO | started process 3566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64o5Zh/profile http://localhost:33723/getInfo.html) 16:00:25 INFO - PROCESS | 3566 | JavaScript error: , line 0: uncaught exception: undefined 16:00:26 INFO - PROCESS | 3566 | __metrics Screen width/height:1600/1200 16:00:26 INFO - PROCESS | 3566 | colorDepth:24 16:00:26 INFO - PROCESS | 3566 | Browser inner width/height: 1024/697 16:00:26 INFO - PROCESS | 3566 | __metrics 16:00:27 INFO - PROCESS | 3566 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:00:27 INFO - PROCESS | 3566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:00:28 INFO - TEST-INFO | 3566: exit 0 16:00:28 INFO - Browser initialized. 16:00:28 INFO - Running cycle 1/1 for kraken test... 16:00:28 INFO - TEST-INFO | started process 3646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64o5Zh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:40 INFO - PROCESS | 3646 | RSS: Main: 159051776 16:00:40 INFO - PROCESS | 3646 | 16:00:43 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33723/tests/kraken/driver.html?testName=audio-beat-detection) 16:00:44 INFO - PROCESS | 3646 | RSS: Main: 215310336 16:00:44 INFO - PROCESS | 3646 | 16:00:46 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33723/tests/kraken/driver.html?testName=audio-dft) 16:00:47 INFO - PROCESS | 3646 | RSS: Main: 189407232 16:00:47 INFO - PROCESS | 3646 | 16:00:50 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33723/tests/kraken/driver.html?testName=audio-fft) 16:00:51 INFO - PROCESS | 3646 | RSS: Main: 272896000 16:00:51 INFO - PROCESS | 3646 | 16:00:53 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33723/tests/kraken/driver.html?testName=audio-oscillator) 16:00:54 INFO - PROCESS | 3646 | RSS: Main: 182640640 16:00:54 INFO - PROCESS | 3646 | 16:00:56 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:00:57 INFO - PROCESS | 3646 | RSS: Main: 186359808 16:00:57 INFO - PROCESS | 3646 | 16:01:00 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33723/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:00 INFO - PROCESS | 3646 | RSS: Main: 223338496 16:01:00 INFO - PROCESS | 3646 | 16:01:04 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33723/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:04 INFO - PROCESS | 3646 | RSS: Main: 216354816 16:01:04 INFO - PROCESS | 3646 | 16:01:07 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33723/tests/kraken/driver.html?testName=json-parse-financial) 16:01:08 INFO - PROCESS | 3646 | RSS: Main: 219807744 16:01:08 INFO - PROCESS | 3646 | 16:01:10 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:01:10 INFO - PROCESS | 3646 | RSS: Main: 185319424 16:01:10 INFO - PROCESS | 3646 | 16:01:12 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:01:13 INFO - PROCESS | 3646 | RSS: Main: 190615552 16:01:13 INFO - PROCESS | 3646 | 16:01:15 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:01:16 INFO - PROCESS | 3646 | RSS: Main: 195301376 16:01:16 INFO - PROCESS | 3646 | 16:01:18 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:01:19 INFO - PROCESS | 3646 | RSS: Main: 190316544 16:01:19 INFO - PROCESS | 3646 | 16:01:22 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:01:22 INFO - PROCESS | 3646 | RSS: Main: 193490944 16:01:22 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:33723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33723/tests/kraken/driver.html?testName=ai-astar) 16:01:24 INFO - PROCESS | 3646 | RSS: Main: 244203520 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | __start_tp_report 16:01:24 INFO - PROCESS | 3646 | _x_x_mozilla_page_load 16:01:24 INFO - PROCESS | 3646 | _x_x_mozilla_page_load_details 16:01:24 INFO - PROCESS | 3646 | |i|pagename|runs| 16:01:24 INFO - PROCESS | 3646 | |0;ai-astar;105;118;114;112;114;114;114;114;113;113 16:01:24 INFO - PROCESS | 3646 | |1;audio-beat-detection;158;122;122;179;123;122;144;122;158;122 16:01:24 INFO - PROCESS | 3646 | |2;audio-dft;162;161;160;159;166;160;163;161;160;161 16:01:24 INFO - PROCESS | 3646 | |3;audio-fft;76;77;75;129;78;77;74;74;103;75 16:01:24 INFO - PROCESS | 3646 | |4;audio-oscillator;85;85;118;86;85;85;134;86;84;126 16:01:24 INFO - PROCESS | 3646 | |5;imaging-gaussian-blur;116;117;118;117;117;117;116;117;117;116 16:01:24 INFO - PROCESS | 3646 | |6;imaging-darkroom;146;146;147;149;147;146;147;147;147;148 16:01:24 INFO - PROCESS | 3646 | |7;imaging-desaturate;96;96;97;95;95;95;96;95;96;95 16:01:24 INFO - PROCESS | 3646 | |8;json-parse-financial;63;61;62;62;63;62;62;63;62;62 16:01:24 INFO - PROCESS | 3646 | |9;json-stringify-tinderbox;65;66;67;65;65;65;65;65;66;66 16:01:24 INFO - PROCESS | 3646 | |10;stanford-crypto-aes;78;78;88;77;79;90;81;79;78;78 16:01:24 INFO - PROCESS | 3646 | |11;stanford-crypto-ccm;140;132;137;130;138;130;130;127;162;128 16:01:24 INFO - PROCESS | 3646 | |12;stanford-crypto-pbkdf2;169;164;169;165;170;167;166;165;163;161 16:01:24 INFO - PROCESS | 3646 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;66;67;71;66;67 16:01:24 INFO - PROCESS | 3646 | __end_tp_report 16:01:24 INFO - PROCESS | 3646 | __start_cc_report 16:01:24 INFO - PROCESS | 3646 | _x_x_mozilla_cycle_collect,1960 16:01:24 INFO - PROCESS | 3646 | __end_cc_report 16:01:24 INFO - PROCESS | 3646 | __startTimestamp1469746884949__endTimestamp 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | ------- Summary: start ------- 16:01:24 INFO - PROCESS | 3646 | Number of tests: 14 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.25 (2.8%) stddev-sans-first:1.66 16:01:24 INFO - PROCESS | 3646 | Values: 105.0 118.0 114.0 112.0 114.0 114.0 114.0 114.0 113.0 113.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:133.50 stddev:21.12 (15.8%) stddev-sans-first:21.02 16:01:24 INFO - PROCESS | 3646 | Values: 158.0 122.0 122.0 179.0 123.0 122.0 144.0 122.0 158.0 122.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 16:01:24 INFO - PROCESS | 3646 | Values: 162.0 161.0 160.0 159.0 166.0 160.0 163.0 161.0 160.0 161.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.50 stddev:18.09 (24.0%) stddev-sans-first:18.97 16:01:24 INFO - PROCESS | 3646 | Values: 76.0 77.0 75.0 129.0 78.0 77.0 74.0 74.0 103.0 75.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:20.10 (23.6%) stddev-sans-first:20.81 16:01:24 INFO - PROCESS | 3646 | Values: 85.0 85.0 118.0 86.0 85.0 85.0 134.0 86.0 84.0 126.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 16:01:24 INFO - PROCESS | 3646 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 16:01:24 INFO - PROCESS | 3646 | Values: 146.0 146.0 147.0 149.0 147.0 146.0 147.0 147.0 147.0 148.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 16:01:24 INFO - PROCESS | 3646 | Values: 96.0 96.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:01:24 INFO - PROCESS | 3646 | Values: 63.0 61.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 16:01:24 INFO - PROCESS | 3646 | Values: 65.0 66.0 67.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.00 stddev:4.58 (5.8%) stddev-sans-first:4.76 16:01:24 INFO - PROCESS | 3646 | Values: 78.0 78.0 88.0 77.0 79.0 90.0 81.0 79.0 78.0 78.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:10.34 (7.7%) stddev-sans-first:10.83 16:01:24 INFO - PROCESS | 3646 | Values: 140.0 132.0 137.0 130.0 138.0 130.0 130.0 127.0 162.0 128.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.50 stddev:2.88 (1.7%) stddev-sans-first:2.83 16:01:24 INFO - PROCESS | 3646 | Values: 169.0 164.0 169.0 165.0 170.0 167.0 166.0 165.0 163.0 161.0 16:01:24 INFO - PROCESS | 3646 | 16:01:24 INFO - PROCESS | 3646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 16:01:24 INFO - PROCESS | 3646 | Values: 67.0 66.0 67.0 67.0 66.0 66.0 67.0 71.0 66.0 67.0 16:01:24 INFO - PROCESS | 3646 | -------- Summary: end -------- 16:01:24 INFO - PROCESS | 3646 | 16:01:26 INFO - TEST-INFO | 3646: exit 0 16:01:26 INFO - TEST-OK | kraken | took 63692ms 16:01:26 INFO - SUITE-END | took 1186s 16:01:26 INFO - Completed test suite (00:19:46) 16:01:26 INFO - javascript benchmark 16:01:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.403747138158, 2599.2072417912555, 2627.8817453214597, 2632.8946842126315, 2639.7624213820764, 4583.679142460029, 4652.883677908054, 4694.2958556216545, 4702.9294560581575, 4721.291806229063, 4710.811567537303, 4718.386609740737, 4744.4069491313585, 4773.976130119353, 4820.397450318701, 4258.361245813122, 4266.146770645868, 4309.396684464177, 4330.653547716175, 4386.0569977455, 4323.848665296715, 4365.170617582649, 4392.29723244281, 4394.318880573516, 4442.8667139985855, 4199.0, 4263.8081286342185, 4349.217140914634, 4354.129174165179, 4413.646908247332, 4251.9787401062795, 4292.18448494785, 4323.589259020388, 4340.826366945318, 4387.890302742425, 4305.117450922585, 4307.246231909403, 4314.633256173198, 4349.565043495657, 4350.108227813291, 4566.657500687462, 4670.883227919295, 4689.601383882374, 4708.340832283483, 4741.739204343759, 4934.654574179809, 4961.677490963112, 4998.52514011172, 5013.47358527353, 5088.872778180576, 5089.770960306795, 5093.79624815007, 5098.898022039575, 5109.4379618241965, 5116.386033675945, 4699.647526435531, 4713.528647135293, 4750.049990002013, 4753.952460475421, 4754.02542478791, 5026.924596131061, 5082.695038297714, 5130.7947682093045, 5133.537981581676, 5241.921371179359, 4963.6277279204205, 4996.300517927493, 5006.424261209934, 5011.599072074226, 5024.598032157419, 5000.1249781288125, 5015.623828212899, 5023.974880125649, 5060.468650791688, 5076.720780357042, 4858.854234372974, 4989.301497790312, 5001.924971125436, 5034.16936205522, 5095.87260318495, 5025.7989680412375, 5032.245163225545, 5037.949620503748, 5041.6722913010535, 5088.974555127201, 4258.7657678827345, 4288.356746488052, 4289.892752681208, 4303.806328715215, 4346.239408103569, 3662.468942003448, 3687.410014397737, 3725.981370093132, 3739.3269211541638, 3768.660820526166, 4359.585839345257, 4363.956360436418, 4373.540778218305, 4382.145481631052, 4402.3836662867225, 5072.163093089599, 5107.0, 5108.872278193075, 5110.770015349318, 5145.0, 4202.789860506962, 4274.743515389025, 4320.3519472078815, 4364.585364390377, 4400.471943366816, 4538.614217791459, 4544.6818722689095, 4584.908301833944, 4588.2888152336445, 4590.724556526619, 4729.468071373907, 4737.715737055788, 4738.976305118453, 4750.501197374226, 4785.042991401733, 4870.926936095891, 5039.974800125976, 5067.569256613082, 5075.720835354091, 5116.488351164854, 4803.327534145153, 4834.0331933612715, 4840.564349208588, 4857.271409288635, 4880.292357608056, 5052.115879720961, 5065.746712664426, 5065.7720402581235, 5080.364954380702, 5124.077666020152, 4907.5828554571835, 4980.800767969241, 5128.512791284822, 5143.948560514496, 5147.974260128675, 4883.145449546386, 4955.876103097451, 4960.20636698141, 4990.0, 5011.348524691767, 4908.484609115992, 4941.728204948762, 4951.603871690184, 4951.9752401237765, 5002.2496625506465, 4680.4149481314835, 4811.879703007453, 4863.8540843774745, 4890.19311813561, 4934.333864928189, 4942.332785073969, 4992.80028798844, 4994.0, 5022.27177059317, 5039.0, 4784.378030855966, 4811.206150985048, 4817.879553011203, 4823.27650852375, 4879.39007624047], "value": 4638.008714175813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8096528145712, 594.8430303060547, 609.4454046817392, 611.431368826991, 624.0825985800874, 38226.80886595567, 39779.40330895039, 39796.801015994955, 43970.12059758803, 44002.33996490055, 39878.800605997, 40370.394444083366, 40419.191616167656, 40551.0, 40603.59396406043, 7518.962405187966, 7634.885476717854, 7661.310482056614, 7664.041994750656, 7664.693412263503, 7624.123225829017, 7714.228577142297, 7729.884051739228, 7730.4975176613625, 7732.729354472594, 7722.111957124918, 7724.111727151365, 7734.690612375498, 7741.0, 7750.379969602446, 7706.576138312391, 7717.459777815555, 7735.72924947627, 7735.922640773577, 7737.381009519225, 7713.34436572892, 7753.418493613001, 7764.495307804975, 7776.611169441562, 7782.182870798598, 37902.43146352807, 38271.42592861109, 38296.42555361644, 38326.23347533034, 38434.423483647486, 2939.1770304314828, 2990.8654110565076, 3045.512717965115, 3231.74146068314, 3725.0873535983587, 29093.0, 29220.561691574643, 29750.851245743634, 29880.40239195204, 30085.699143008507, 3084.90745277642, 3102.1934297082694, 3105.627324721025, 3108.8445577721022, 3113.8910138145056, 174640.12679936647, 175415.0, 175671.0, 176178.0, 176207.0, 51800.74099629478, 52085.218721719204, 52208.73895630497, 52255.477445225064, 52302.47697523052, 32879.83560082184, 33696.32607347839, 33823.0, 35476.0, 54209.0, 15316.0, 15493.380264789508, 15534.766978495332, 15536.145511996723, 15568.922155389151, 11747.941260293816, 11941.462634181482, 11941.940290298493, 11948.402579870972, 11950.940245298892, 18171.818281817013, 18205.817941820413, 18397.448076557725, 18418.079096045145, 18500.629987400178, 6726.7981960541265, 6797.694103765342, 6799.796006119825, 6903.620300883399, 6921.93078069223, 727.6325455644866, 875.4047247871508, 877.5436772878068, 921.3964853021282, 936.8266870628955, 27867.860660696566, 27956.30109247285, 28114.987318308158, 28552.71447285542, 28883.71116288852, 868.9000764912116, 920.9585568649427, 968.5689868008809, 969.8496733006396, 969.9612015519441, 14467.710645787025, 15186.696266074616, 15211.923940380228, 15321.923390382977, 15371.308291126927, 399998.0, 403565.0, 404188.0, 404482.0, 407230.0, 49330.013399732525, 49678.0, 49711.75144124256, 49739.25391119136, 49793.0, 1062.8033813744482, 1132.4960392625203, 1148.3913525831156, 1166.2302880099264, 1196.3360335013977, 26936.498255226696, 29003.41993160167, 29197.708022919498, 29288.414231715673, 29775.25561860884, 41323.58676413318, 41849.79075104605, 41933.0, 41948.37077443902, 41963.37054944239, 300293.0, 301272.0, 301501.0, 302602.0, 302653.0, 21939.122435102418, 22452.438689032904, 22550.097996079974, 22635.773642264026, 25450.363740906625, 41253.38119928264, 41430.792846035576, 41572.3764143532, 41627.7918610405, 42003.0, 34528.48207276843, 35805.46291805573, 35812.462813057304, 35884.461733074546, 35955.0, 35032.0, 35049.47425788564, 35260.0, 35539.289214216085, 35765.28469430649, 32270.35459290848, 32411.0, 34107.0, 34138.65861341355, 35703.0, 30363.696363036972, 32441.0, 32474.67525324811, 32549.34901302008, 32626.184345391554, 24603.015879364626, 24714.59824980097, 24969.37576560528, 25306.36734081589, 25360.873195633903], "value": 17077.900649423926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.50493269960475, 341.603739661992, 356.86260789596014, 358.92642008388276, 368.1771241275748, 12801.231926084442, 13362.465501379957, 13819.0, 16795.748063779054, 16893.324267029337, 16698.248578813953, 16710.415135470263, 16903.492895213134, 16957.83042169578, 17086.572835679115, 4983.551480366776, 5052.115879721034, 5276.973615131919, 5312.840614781543, 5388.380336261341, 3463.7402194835363, 5394.433584473632, 5430.402655707869, 5431.21247419124, 5432.456754324556, 4435.556444355571, 5820.941790582104, 5862.267216597926, 5917.585768996172, 5934.851628709273, 5039.647224694273, 5907.350191478934, 5914.88170236595, 5915.201447804534, 5920.822375328747, 5124.128898087297, 5213.947860521384, 5216.7913283468615, 5218.712970786605, 5220.190870415092, 12171.026317894548, 12325.075619328496, 18242.817571824246, 20505.8974705127, 20623.69064464034, 1771.1941066814568, 1835.4218421197281, 1892.1485331600834, 2064.4735592423835, 2136.3484137338105, 9142.725718228463, 9533.142017218484, 10136.341137826017, 11678.6496405108, 13152.736945261042, 1721.712766221827, 1723.3451288510412, 1731.333436626895, 1748.7551742756025, 1789.910504474771, 70028.64985675039, 70255.64872175606, 70354.64822675905, 71155.2884471159, 71768.0, 9487.0, 9531.714048578553, 9643.951780241194, 9714.271429642806, 9946.602135914627, 13371.866281337258, 13392.866071339356, 13411.195328280335, 13422.127561708458, 13430.798538021938, 6898.206706228848, 6937.410320122846, 6957.199922009034, 7038.612876291853, 7104.21853596104, 6605.735770569124, 6691.832704182337, 6735.730570777212, 6757.8648427031185, 6804.013418054355, 4154.293770059097, 4164.104717485755, 4171.812268447927, 4208.368744688321, 4264.509581398117, 1691.1628743771666, 1769.646070785848, 1772.299941523091, 1796.8203179681927, 1804.8736588438683, 767.3784234769854, 773.7117699031163, 816.8978877640295, 848.4061157189992, 920.4799288402031, 16461.58846028859, 16628.58428539296, 16681.83318166803, 17084.0, 17469.21388537519, 816.1475642629049, 832.4040146566894, 838.3000194837257, 841.2260720137489, 880.5509190312858, 8995.955020224988, 9774.853377199348, 9803.558839852081, 9827.950860245654, 9860.704178874645, 380807.0, 381575.0, 384074.0, 399689.0, 402024.0, 78123.60938195273, 79888.0, 81315.59342203251, 81348.0, 81809.0, 850.1583432401877, 880.1462581296132, 881.0176653031951, 881.4050515901869, 881.7398867334152, 14999.850001499844, 15165.696686066438, 15348.693026139637, 15421.768673469682, 15530.611734706723, 25728.356791080372, 26018.479630406906, 36777.264454711294, 37853.04804602222, 37974.0, 52156.47843521668, 52339.47660523498, 52635.73682131718, 54401.0, 54977.72511137419, 7516.661750221144, 7650.426218033558, 7729.111152217567, 7849.3328067114935, 7858.371330293677, 8964.0, 10969.670909872717, 11040.5031773572, 11395.487203075716, 12342.876571234172, 9910.702678919644, 10176.236782241214, 10181.898181018096, 10273.486325683836, 10568.84146737815, 9549.47477888695, 9592.808143837225, 9849.852252216078, 10232.693019209435, 10286.251337272832, 9838.803223935623, 10022.849657255292, 10193.541290642088, 10475.319104258198, 10850.67447976562, 6723.5293529452465, 6829.282925292773, 6900.30996900326, 7021.192562855337, 7825.334846538108, 8356.415050946376, 10225.43760093202, 10446.268761186948, 10452.372857628567, 10852.18608604342], "value": 8039.509374214983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1170.444039081436, 1286.2604002698447, 1346.9663258418539, 1366.7881478370853, 1637.6560922206343, 6510.283868774431, 7425.66584503698, 7656.157822639505, 7657.999999999993, 7809.531428114317, 7656.846863062736, 7715.0, 7715.15133335334, 7718.8456230875345, 7735.1491335953, 2149.118861266877, 2174.7825217478203, 2176.075168053571, 2176.1730542393866, 2177.1835561664375, 2136.7756385579523, 2171.695962565242, 2210.5799898019327, 2212.2036067015943, 2213.734351877769, 2168.7505936817233, 2175.282156888231, 2183.366823621148, 2183.8143757780526, 2214.202886960693, 2088.1751708075303, 2093.5498867743354, 2094.413564202026, 2094.790520947901, 2097.538541520863, 2035.2266138867283, 2093.8638988465855, 2106.441792924876, 2116.8412369072225, 2122.2253877334815, 7561.357284630813, 7600.923990760077, 7664.156942736295, 7665.233476652346, 7725.806854828675, 4548.727076375428, 4709.740964246965, 4721.433427988629, 4722.677650257933, 4728.456227533843, 2732.4671689020647, 2839.872205750746, 2870.1389583125188, 2870.6842247352774, 2876.798624096314, 850.817074329016, 854.9691344184879, 865.1694373401542, 871.7036207689416, 877.6006916852816, 10455.424951627658, 10558.52486638103, 10585.100266477359, 10591.788164236672, 10603.469826508644, 3821.8280177392085, 3991.3015222335976, 4132.235536425771, 4140.3168477201525, 4174.3321068628875, 7964.761057168294, 8016.31861291785, 8042.437029408003, 8049.275565199043, 8053.15441878606, 4623.9075218495445, 4635.559621835921, 4641.419822522184, 4647.55848194421, 4647.930281045787, 3714.0529165063276, 4091.85678501251, 4249.97875010623, 4295.935560966525, 4302.462192225972, 3294.472884338494, 3343.8996830095134, 3459.930801383958, 3460.2387474755515, 3488.0, 998.9750256243507, 1008.1632245236436, 1013.9847902281472, 1040.6877936618985, 1044.8014877173314, 850.6384786465727, 852.7612268564811, 866.2939704141105, 903.6069309850236, 904.8418024928103, 5332.546733527616, 5409.0263752524925, 5472.2338872557875, 5611.663300202001, 5756.42435756421, 830.2195935820309, 841.3437518735396, 852.3436953545735, 885.968991085309, 894.8970868350093, 3690.557133143986, 3769.8680546180753, 3786.8674596388996, 3826.712996525216, 3842.5773164951834, 9193.264538836876, 9433.858492122623, 9520.143187113194, 9527.809443811086, 9571.138597526256, 9423.952880235693, 9426.575804088832, 9437.103475169848, 9446.433214007182, 9449.716508504756, 7068.3991860691385, 7192.280771922766, 7218.494705370574, 7220.638968051577, 7220.675069621774, 5380.704061276668, 5423.430539793265, 5555.638883472561, 5559.19391688211, 5715.657060576379, 8848.734537963872, 9015.413998090104, 9041.638334466548, 9048.547572621474, 9055.320850936338, 8785.780355491164, 9045.321600880092, 9089.681861134828, 9147.817043659223, 9172.633094676139, 5948.078047902582, 6380.425761681471, 6520.347965203442, 6638.137042184679, 6643.60138391698, 7472.065991751031, 7644.770656880302, 7651.196624354363, 7727.11138219112, 7730.420218483524, 6566.6388348641285, 6570.474362050929, 6600.735970561123, 6661.833454163685, 6866.004429357815, 6542.182227221598, 6698.598084114774, 6771.762988295386, 6811.0, 6896.379325860697, 6020.4280593343565, 6404.815109204812, 6424.871502569829, 6434.871302573829, 6448.677566121582, 4353.194658988097, 4461.13007963444, 4481.641468682563, 4572.657050721143, 4584.243599806128, 4607.677462577587, 4753.168195565831, 4767.284907263938, 4826.710397376169, 4963.379577552806], "value": 4081.40460143632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.60724200603164, 291.1150103684798, 298.6088224426003, 299.87255416448005, 301.8354996526895, 4810.759462026897, 4861.690696918961, 4865.124277630025, 4873.463918968911, 4888.804447822083, 4567.931481027787, 4672.275797251432, 4695.530446955311, 4716.7405792681475, 4825.951740482594, 3701.463287823264, 3730.3772858806437, 3748.5876553579083, 3797.9810100949458, 3800.4109363048633, 3818.9427158592644, 3821.331267028273, 3835.673967712748, 3851.73037887348, 3856.575776664579, 3545.556805399325, 3726.3665176919853, 3769.453429252757, 3803.3914573668217, 3805.429185622165, 3741.27045226181, 3750.474933509311, 3751.831167597451, 3767.303048935928, 3768.868089616864, 3270.394976929276, 3281.704646581819, 3282.0810173151317, 3296.719778818803, 3305.6529064448127, 4716.976415117902, 4721.639180409795, 4721.795942034759, 4744.3595114659765, 4760.310089918098, 4090.713650044498, 4231.661467082626, 4256.1487702459635, 4272.060146767706, 4315.158544083905, 5036.445990940993, 5038.370203724535, 5064.898702025976, 5066.240063990431, 5084.771185296633, 3562.0, 3571.357155711971, 3574.303010912873, 3575.606683264839, 3603.6036036036016, 5183.896322073575, 5233.639253794003, 5297.49673780994, 5314.176302673091, 5341.866453338659, 3644.599094099647, 3651.580068292127, 3655.524781778352, 3656.7018708358682, 3665.578458477256, 3695.3902606069696, 3705.7220708446434, 3706.4069748840056, 3710.7216958728204, 3715.3126671565847, 4241.1941731071, 4284.121755040209, 4293.0, 4293.570642935744, 4294.677899157576, 4922.286268491049, 5040.747962601855, 5044.924326135111, 5084.593232541388, 5092.26162206478, 1267.993660031694, 1284.7751643462357, 1291.5673249461347, 1293.5149319005372, 1296.0992110483123, 822.2763967708378, 834.1283358889974, 854.7605971341579, 877.7015814623059, 880.5025160784137, 4425.690201685916, 4445.866624001285, 4462.174497717932, 4477.0, 4501.68488205829, 5182.663126896739, 5204.713740744295, 5219.947800521946, 5237.711925844115, 5243.23973023917, 4331.263685173528, 4384.583464570861, 4460.197164510354, 4482.6327969968825, 4484.439445069366, 2750.339918419565, 2750.5324094903913, 2755.820871643377, 2757.6277202577394, 2764.3641962348775, 4849.248366503198, 4864.467692676795, 4874.317595536628, 4892.2661600760175, 4895.167821470359, 5050.974745126251, 5298.0, 5321.840344789663, 5359.598030147755, 5367.141257398797, 4920.532549407801, 4934.5805606523845, 4944.491929961325, 4979.427365852901, 4987.10232158215, 5245.89508209826, 5301.973490132525, 5318.7340632967425, 5338.866528336667, 5338.866528336823, 4882.975585122052, 5142.434332223377, 5185.896282074413, 5187.651210685173, 5246.947530524799, 4933.728644924564, 4969.329140566122, 4988.176950803077, 5002.574781143643, 5003.399592048978, 3836.5779764225354, 3844.94232586517, 3858.5176852893387, 3866.149447121629, 3882.3400021995762, 5092.898142037213, 5188.533032027136, 5203.375594928632, 5210.296609957607, 5294.808668049658, 5032.3206367139965, 5041.218611115283, 5042.924356134734, 5043.5460808527405, 5071.239314102914, 5075.974620126875, 5078.441371449064, 5090.770915308746, 5095.92356114666, 5099.464556221544, 4876.902461950812, 4893.039472045823, 4946.579540739078, 4948.183549714401, 4966.230234313687, 4854.320395144612, 4927.236278376858, 5036.395632524121, 5078.492150784892, 5097.343363406833, 4929.408470983361, 4942.505749425029, 4946.208606622923, 4949.950500494949, 4970.8260210893895], "value": 3813.736612575216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5810669691265, 613.4111253196932, 634.8761991411674, 709.9964500177498, 735.5219107580073, 12414.937925310383, 13633.045686801928, 13699.0, 13708.108972916754, 13709.794353084711, 12827.0, 12981.221126732402, 12981.805272920914, 13001.934990325035, 13018.674533136676, 630.7224821078734, 642.3063091860779, 743.2233316184573, 754.0875540595858, 768.4006474949521, 765.8123759678887, 783.5181363461487, 783.9725609603665, 784.231453175888, 784.2980532423478, 836.2682652678906, 837.9832403351929, 838.1283465196188, 838.1534650003509, 838.6184286149818, 670.47367816264, 794.5351969098084, 819.3690858039276, 833.7790485521372, 833.791552111972, 598.0282041682266, 601.5247954116243, 603.0983679399283, 603.1194456094108, 603.7584966013586, 12778.10553261272, 12785.61643150707, 12820.551280705224, 12835.486580536768, 12844.422001009976, 12277.0, 12412.441440135215, 12615.936920315431, 12810.359482025955, 13024.804627930589, 11122.221444498888, 11276.605318813803, 11538.192326537146, 11612.0, 12026.098042646836, 4009.1981603679087, 4074.164796216798, 4076.103257283393, 4169.061961058768, 4175.039740859589, 60694.696526517524, 62806.68596657033, 63317.366826332065, 63710.68144659247, 63821.68089159571, 10168.949155254177, 10352.0, 10455.84316235257, 10503.159747220205, 10504.159667226604, 18763.81236187648, 18782.530436738918, 18794.436166915013, 18796.81203187978, 18805.34181303675, 6709.664516774142, 6788.932110678928, 6891.173059232924, 7056.259092795285, 7112.537685050455, 3731.1231860512758, 3736.143014081683, 3841.4429907663234, 3847.96152038476, 3872.1481274119647, 2774.3480282133683, 2805.410863718601, 2807.4244779820087, 2854.628898243215, 2858.0139851751114, 492.38206051405257, 493.8691246819596, 497.16228155558, 502.86171302891995, 506.96958182509167, 511.5699236618464, 546.7594258526236, 548.6625725179066, 550.0896017091719, 561.9550435965112, 7877.761288743036, 8077.434579579491, 8189.590520473953, 8662.87005694915, 8728.607212675444, 590.5688847141611, 616.8149555133532, 619.331122387829, 623.4856243599049, 642.4121928435522, 3872.6514613684903, 3945.2306800174265, 4118.608732170499, 4137.213929353474, 4158.313878210061, 92897.0, 95750.0, 96293.0370696298, 96614.0, 99540.0, 73134.26865731274, 73936.0, 83122.0, 85192.0, 87502.0, 79358.0, 80678.19321806825, 80704.0, 81001.59499202466, 81181.0, 8259.95870020646, 9039.45763254207, 9052.366334356531, 9091.181793638605, 9205.677801277192, 42028.57971420247, 47597.28604070872, 48596.27105593348, 48946.75526622344, 49969.25046124238, 64992.52585952487, 73779.63110184629, 73946.0, 74129.0, 75616.24383756092, 11307.830382544433, 11493.310401375944, 11961.521539138685, 11978.820317695416, 12078.094142939139, 13572.86427135716, 13652.843307673205, 13681.726365472436, 14010.369533371226, 14025.579232623038, 11431.542738290707, 11829.585964491545, 11984.64046078619, 12106.213096148722, 12204.389780511117, 11606.419679016184, 11900.40497975115, 12011.339376334385, 12142.575009874612, 12539.811902821648, 11280.605178818701, 11598.594049208237, 11654.125940554322, 12039.939800300943, 12123.090768192244, 9765.85351219718, 9912.207023437963, 10132.544035518273, 10399.168066554506, 10485.266031378036, 9572.282078844253, 9888.703338899844, 9955.950220248853, 10083.798324033625, 10099.394036357842], "value": 6693.739601240587, "unit": "score"}], "name": "dromaeo_css", "value": 6362.760488199212, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 114.0, 112.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 122.0, 179.0, 123.0, 122.0, 144.0, 122.0, 158.0, 122.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 159.0, 166.0, 160.0, 163.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 129.0, 78.0, 77.0, 74.0, 74.0, 103.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 118.0, 86.0, 85.0, 85.0, 134.0, 86.0, 84.0, 126.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 88.0, 77.0, 79.0, 90.0, 81.0, 79.0, 78.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 137.0, 130.0, 138.0, 130.0, 130.0, 127.0, 162.0, 128.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 169.0, 165.0, 170.0, 167.0, 166.0, 165.0, 163.0, 161.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 71.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1528.8000000000002, "alertThreshold": 2.0}]} 16:01:26 INFO - Return code: 0 16:01:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:01:26 INFO - # TBPL SUCCESS # 16:01:26 INFO - Running post-action listener: _resource_record_post_action 16:01:26 INFO - [mozharness: 2016-07-28 23:01:26.215716Z] Finished run-tests step (success) 16:01:26 INFO - Running post-run listener: _resource_record_post_run 16:01:26 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7639040; Write bytes: 429740032; Read time: 1496; Write time: 449972 16:01:26 INFO - TinderboxPrint: CPU usage
13.0% 16:01:26 INFO - TinderboxPrint: I/O read bytes / time
7,639,040 / 1,496 16:01:26 INFO - TinderboxPrint: I/O write bytes / time
429,740,032 / 449,972 16:01:26 INFO - TinderboxPrint: CPU idle
8,356.4 (87.0%) 16:01:26 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 16:01:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:01:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13533184; Read time: 0; Write time: 10804 16:01:26 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5484544; Write bytes: 415870976; Read time: 1428; Write time: 439168 16:01:26 INFO - Running post-run listener: _upload_blobber_files 16:01:26 INFO - Blob upload gear active. 16:01:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:01:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:01:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:01:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:01:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:30 INFO - (blobuploader) - INFO - Done attempting. 16:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:31 INFO - (blobuploader) - INFO - Done attempting. 16:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:32 INFO - (blobuploader) - INFO - Done attempting. 16:01:32 INFO - (blobuploader) - INFO - Iteration through files over. 16:01:32 INFO - Return code: 0 16:01:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:01:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:01:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1fccfc451a69061504bd08bff33d0a645e68280b3032a29b42fafcac0439f1af06b42a16a35da65a81af7b9ff0e145e0ceccc2ee09bbd31766500d7df1f0fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92cc292e6663cb0852e7fb7a89d3967b1205d20a9a88b44367faa99504f6fb63115949a61a5f700472c8cacee46950f8694523a5c0230f4294b25214fce072ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dddd1363b40f9b8962b34fe619f244eabd92af46fcf9dc161299390824e16cd492cfe583c6fe363370a86667b8ceca0e0e619a671526c9289e0785c5fb325e71"} 16:01:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:01:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:01:32 INFO - Contents: 16:01:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1fccfc451a69061504bd08bff33d0a645e68280b3032a29b42fafcac0439f1af06b42a16a35da65a81af7b9ff0e145e0ceccc2ee09bbd31766500d7df1f0fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92cc292e6663cb0852e7fb7a89d3967b1205d20a9a88b44367faa99504f6fb63115949a61a5f700472c8cacee46950f8694523a5c0230f4294b25214fce072ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dddd1363b40f9b8962b34fe619f244eabd92af46fcf9dc161299390824e16cd492cfe583c6fe363370a86667b8ceca0e0e619a671526c9289e0785c5fb325e71"} 16:01:32 INFO - Running post-run listener: copy_logs_to_upload_dir 16:01:32 INFO - Copying logs to upload dir... 16:01:32 INFO - mkdir: /builds/slave/test/build/upload/logs 16:01:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.213133 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-28 16:01:32.403568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:01:32.407044) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1fccfc451a69061504bd08bff33d0a645e68280b3032a29b42fafcac0439f1af06b42a16a35da65a81af7b9ff0e145e0ceccc2ee09bbd31766500d7df1f0fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92cc292e6663cb0852e7fb7a89d3967b1205d20a9a88b44367faa99504f6fb63115949a61a5f700472c8cacee46950f8694523a5c0230f4294b25214fce072ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dddd1363b40f9b8962b34fe619f244eabd92af46fcf9dc161299390824e16cd492cfe583c6fe363370a86667b8ceca0e0e619a671526c9289e0785c5fb325e71"} build_url:https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/bBwre-nSQMS_hhxTDRxh7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1fccfc451a69061504bd08bff33d0a645e68280b3032a29b42fafcac0439f1af06b42a16a35da65a81af7b9ff0e145e0ceccc2ee09bbd31766500d7df1f0fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92cc292e6663cb0852e7fb7a89d3967b1205d20a9a88b44367faa99504f6fb63115949a61a5f700472c8cacee46950f8694523a5c0230f4294b25214fce072ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dddd1363b40f9b8962b34fe619f244eabd92af46fcf9dc161299390824e16cd492cfe583c6fe363370a86667b8ceca0e0e619a671526c9289e0785c5fb325e71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:01:32.433120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:01:32.433466) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469745631.360904-1270821140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:01:32.519333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:01:32.519781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:01:32.520125) ========= ========= Total master_lag: 0.01 =========