builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1469875852.54 results: success (0) buildid: 20160730005025 builduid: 3f3091f308c44c2d935d40d1084afe25 revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.535940) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.536960) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.537585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.553097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.553478) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:50:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-30 03:50:52 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.682296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.683108) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014605 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:52.735452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:50:52.736285) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3565c8b1cdb575db1c80c7791984a6490598b84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c3565c8b1cdb575db1c80c7791984a6490598b84 --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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:50:53,001 truncating revision to first 12 chars 2016-07-30 03:50:53,001 Setting DEBUG logging. 2016-07-30 03:50:53,001 attempt 1/10 2016-07-30 03:50:53,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3565c8b1cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:50:53,989 unpacking tar archive at: fx-team-c3565c8b1cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:50:54.053519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:54.053899) ========= script_repo_revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:54.054368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:54.054683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:50:54.066222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-30 03:50:54.066791) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:54 INFO - MultiFileLogger online at 20160730 03:50:54 in /builds/slave/test 03:50:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:54 INFO - {'append_to_log': False, 03:50:54 INFO - 'base_work_dir': '/builds/slave/test', 03:50:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:54 INFO - 'branch': 'Fx-Team-Non-PGO', 03:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:54 INFO - 'config_files': ('talos/linux_config.py',), 03:50:54 INFO - 'default_actions': ('clobber', 03:50:54 INFO - 'read-buildbot-config', 03:50:54 INFO - 'download-and-extract', 03:50:54 INFO - 'populate-webroot', 03:50:54 INFO - 'create-virtualenv', 03:50:54 INFO - 'install', 03:50:54 INFO - 'run-tests'), 03:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:54 INFO - 'download_minidump_stackwalk': True, 03:50:54 INFO - 'download_symbols': 'ondemand', 03:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:54 INFO - 'installer_path': 'installer.exe', 03:50:54 INFO - 'log_level': 'info', 03:50:54 INFO - 'log_name': 'talos', 03:50:54 INFO - 'log_to_console': True, 03:50:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:54 INFO - 'opt_config_files': (), 03:50:54 INFO - 'pip_index': False, 03:50:54 INFO - 'sps_profile': False, 03:50:54 INFO - 'sps_profile_interval': 0, 03:50:54 INFO - 'suite': 'dromaeojs', 03:50:54 INFO - 'system_bits': '32', 03:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:54 INFO - 'title': 'talos-linux64-ix-060', 03:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:54 INFO - 'use_talos_json': True, 03:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:54 INFO - 'work_dir': 'build'} 03:50:54 INFO - [mozharness: 2016-07-30 10:50:54.430487Z] Running clobber step. 03:50:54 INFO - Running pre-action listener: _resource_record_pre_action 03:50:54 INFO - Running main action method: clobber 03:50:54 INFO - rmtree: /builds/slave/test/build 03:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:54 INFO - Running post-action listener: _resource_record_post_action 03:50:54 INFO - [mozharness: 2016-07-30 10:50:54.881361Z] Finished clobber step (success) 03:50:54 INFO - [mozharness: 2016-07-30 10:50:54.881474Z] Running read-buildbot-config step. 03:50:54 INFO - Running pre-action listener: _resource_record_pre_action 03:50:54 INFO - Running main action method: read_buildbot_config 03:50:54 INFO - Using buildbot properties: 03:50:54 INFO - { 03:50:54 INFO - "project": "", 03:50:54 INFO - "product": "firefox", 03:50:54 INFO - "script_repo_revision": "production", 03:50:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:50:54 INFO - "repository": "", 03:50:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:50:54 INFO - "buildid": "20160730005025", 03:50:54 INFO - "pgo_build": "False", 03:50:54 INFO - "basedir": "/builds/slave/test", 03:50:54 INFO - "buildnumber": 1840, 03:50:54 INFO - "slavename": "talos-linux64-ix-060", 03:50:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:50:54 INFO - "platform": "ubuntu64_hw", 03:50:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:50:54 INFO - "branch": "fx-team", 03:50:54 INFO - "repo_path": "integration/fx-team", 03:50:54 INFO - "revision": "c3565c8b1cdb575db1c80c7791984a6490598b84", 03:50:54 INFO - "stage_platform": "linux64", 03:50:54 INFO - "builduid": "3f3091f308c44c2d935d40d1084afe25", 03:50:54 INFO - "slavebuilddir": "test" 03:50:54 INFO - } 03:50:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:50:54 INFO - Running post-action listener: _resource_record_post_action 03:50:54 INFO - [mozharness: 2016-07-30 10:50:54.883912Z] Finished read-buildbot-config step (success) 03:50:54 INFO - [mozharness: 2016-07-30 10:50:54.884001Z] Running download-and-extract step. 03:50:54 INFO - Running pre-action listener: _resource_record_pre_action 03:50:54 INFO - Running main action method: download_and_extract 03:50:54 INFO - mkdir: /builds/slave/test/build/tests 03:50: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')]} 03:50:54 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:55 INFO - Downloaded 1361 bytes. 03:50:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:50:55 INFO - Using the following test package requirements: 03:50:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:50:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'jsshell-linux-x86_64.zip'], 03:50:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:50:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:50:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:57 INFO - Downloaded 20231869 bytes. 03:50:57 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'] 03:50:57 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 03:50:58 INFO - Return code: 0 03:50:58 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 03:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:58 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:50:59 INFO - Downloaded 20231869 bytes. 03:50:59 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'] 03:50:59 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 03:51:00 INFO - Return code: 0 03:51:00 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')]} 03:51:00 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:01 INFO - Downloaded 14413725 bytes. 03:51:01 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'] 03:51:01 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 03:51:01 INFO - Return code: 0 03:51: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')]} 03:51:01 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:02 INFO - Downloaded 55584976 bytes. 03:51:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:02 INFO - mkdir: /builds/slave/test/properties 03:51:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:02 INFO - Contents: 03:51:02 INFO - build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:03 INFO - Running post-action listener: _resource_record_post_action 03:51:03 INFO - Running post-action listener: set_extra_try_arguments 03:51:03 INFO - [mozharness: 2016-07-30 10:51:03.592665Z] Finished download-and-extract step (success) 03:51:03 INFO - [mozharness: 2016-07-30 10:51:03.592901Z] Running populate-webroot step. 03:51:03 INFO - Running pre-action listener: _resource_record_pre_action 03:51:03 INFO - Running main action method: populate_webroot 03:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:03 INFO - '--tppagecycles', 03:51:03 INFO - '7'], 03:51:03 INFO - 'tests': ['tsvgm']}}, 03:51:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['damp', 'tps']}, 03:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'tests': ['damp', 'tps']}, 03:51:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['dromaeo_dom']}, 03:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['basic_compositor_video']}, 03:51:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['a11yr', 03:51:03 INFO - 'ts_paint', 03:51:03 INFO - 'tpaint', 03:51:03 INFO - 'sessionrestore', 03:51:03 INFO - 'sessionrestore_no_auto_restore', 03:51:03 INFO - 'tabpaint']}, 03:51:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['tsvgx', 03:51:03 INFO - 'tsvgr_opacity', 03:51:03 INFO - 'tart', 03:51:03 INFO - 'tscrollx', 03:51:03 INFO - 'cart']}, 03:51:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:03 INFO - 'tsvgr_opacity', 03:51:03 INFO - 'tart', 03:51:03 INFO - 'tscrollx', 03:51:03 INFO - 'cart']}, 03:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'talos_options': ['--disable-e10s'], 03:51:03 INFO - 'tests': ['tp5o']}, 03:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'tests': ['tp5o']}, 03:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'talos_options': ['--disable-e10s', 03:51:03 INFO - '--xperf_path', 03:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:03 INFO - 'tests': ['tp5n']}, 03:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:03 INFO - 'talos_options': ['--xperf_path', 03:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:03 INFO - 'tests': ['tp5n']}}, 03:51:03 INFO - 'talos.zip': {'path': '', 03:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:03 INFO - Running post-action listener: _resource_record_post_action 03:51:03 INFO - [mozharness: 2016-07-30 10:51:03.611766Z] Finished populate-webroot step (success) 03:51:03 INFO - [mozharness: 2016-07-30 10:51:03.611855Z] Running create-virtualenv step. 03:51:03 INFO - Running pre-action listener: _resource_record_pre_action 03:51:03 INFO - Running main action method: create_virtualenv 03:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:03 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 03:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:03 INFO - Using real prefix '/usr' 03:51:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:06 INFO - Installing pip.................done. 03:51:06 INFO - Return code: 0 03:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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')]} 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51: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', 'pip>=1.5'] in /builds/slave/test/build 03:51: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 pip>=1.5 03:51:06 INFO - Using env: {'DISPLAY': ':0', 03:51:06 INFO - 'HOME': '/home/cltbld', 03:51:06 INFO - 'LANG': 'en_US.UTF-8', 03:51:06 INFO - 'LANGUAGE': 'en_US:en', 03:51:06 INFO - 'LOGNAME': 'cltbld', 03:51:06 INFO - 'MAIL': '/var/mail/cltbld', 03:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:06 INFO - 'MOZ_NO_REMOTE': '1', 03:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:06 INFO - 'NO_EM_RESTART': '1', 03:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:06 INFO - 'PWD': '/builds/slave/test', 03:51:06 INFO - 'SHELL': '/bin/bash', 03:51:06 INFO - 'SHLVL': '1', 03:51:06 INFO - 'TERM': 'linux', 03:51:06 INFO - 'TMOUT': '86400', 03:51:06 INFO - 'USER': 'cltbld', 03:51:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:06 INFO - '_': '/tools/buildbot/bin/python'} 03:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:06 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 03:51:06 INFO - Cleaning up... 03:51:06 INFO - Return code: 0 03:51:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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')]} 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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', '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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:51: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 psutil>=3.1.1 03:51:06 INFO - Using env: {'DISPLAY': ':0', 03:51:06 INFO - 'HOME': '/home/cltbld', 03:51:06 INFO - 'LANG': 'en_US.UTF-8', 03:51:06 INFO - 'LANGUAGE': 'en_US:en', 03:51:06 INFO - 'LOGNAME': 'cltbld', 03:51:06 INFO - 'MAIL': '/var/mail/cltbld', 03:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:06 INFO - 'MOZ_NO_REMOTE': '1', 03:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:06 INFO - 'NO_EM_RESTART': '1', 03:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:06 INFO - 'PWD': '/builds/slave/test', 03:51:06 INFO - 'SHELL': '/bin/bash', 03:51:06 INFO - 'SHLVL': '1', 03:51:06 INFO - 'TERM': 'linux', 03:51:06 INFO - 'TMOUT': '86400', 03:51:06 INFO - 'USER': 'cltbld', 03:51:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:06 INFO - '_': '/tools/buildbot/bin/python'} 03:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:06 INFO - Downloading/unpacking psutil>=3.1.1 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:08 INFO - Installing collected packages: psutil 03:51:08 INFO - Running setup.py install for psutil 03:51:08 INFO - building 'psutil._psutil_linux' extension 03:51:08 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 03:51:08 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 03:51:08 INFO - building 'psutil._psutil_posix' extension 03:51:08 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 03:51:09 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 03:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:09 INFO - Successfully installed psutil 03:51:09 INFO - Cleaning up... 03:51:09 INFO - Return code: 0 03:51:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:09 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')]} 03:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:09 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')]} 03:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:09 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:09 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 03:51:09 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 03:51:09 INFO - Using env: {'DISPLAY': ':0', 03:51:09 INFO - 'HOME': '/home/cltbld', 03:51:09 INFO - 'LANG': 'en_US.UTF-8', 03:51:09 INFO - 'LANGUAGE': 'en_US:en', 03:51:09 INFO - 'LOGNAME': 'cltbld', 03:51:09 INFO - 'MAIL': '/var/mail/cltbld', 03:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:09 INFO - 'MOZ_NO_REMOTE': '1', 03:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:09 INFO - 'NO_EM_RESTART': '1', 03:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:09 INFO - 'PWD': '/builds/slave/test', 03:51:09 INFO - 'SHELL': '/bin/bash', 03:51:09 INFO - 'SHLVL': '1', 03:51:09 INFO - 'TERM': 'linux', 03:51:09 INFO - 'TMOUT': '86400', 03:51:09 INFO - 'USER': 'cltbld', 03:51:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:09 INFO - '_': '/tools/buildbot/bin/python'} 03:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:11 INFO - Installing collected packages: mozsystemmonitor 03:51:11 INFO - Running setup.py install for mozsystemmonitor 03:51:11 INFO - Successfully installed mozsystemmonitor 03:51:11 INFO - Cleaning up... 03:51:11 INFO - Return code: 0 03:51:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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')]} 03:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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', '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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:51: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 jsonschema==2.5.1 03:51:11 INFO - Using env: {'DISPLAY': ':0', 03:51:11 INFO - 'HOME': '/home/cltbld', 03:51:11 INFO - 'LANG': 'en_US.UTF-8', 03:51:11 INFO - 'LANGUAGE': 'en_US:en', 03:51:11 INFO - 'LOGNAME': 'cltbld', 03:51:11 INFO - 'MAIL': '/var/mail/cltbld', 03:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:11 INFO - 'MOZ_NO_REMOTE': '1', 03:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:11 INFO - 'NO_EM_RESTART': '1', 03:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:11 INFO - 'PWD': '/builds/slave/test', 03:51:11 INFO - 'SHELL': '/bin/bash', 03:51:11 INFO - 'SHLVL': '1', 03:51:11 INFO - 'TERM': 'linux', 03:51:11 INFO - 'TMOUT': '86400', 03:51:11 INFO - 'USER': 'cltbld', 03:51:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:11 INFO - '_': '/tools/buildbot/bin/python'} 03:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:13 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 03:51:13 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 03:51:13 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 03:51:13 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 03:51:13 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 03:51:13 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 03:51:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:13 INFO - warning: no files found matching '*.txt' 03:51:13 INFO - no previously-included directories found matching 'build' 03:51:13 INFO - no previously-included directories found matching 'dist' 03:51:13 INFO - no previously-included directories found matching '.git*' 03:51:13 INFO - Installing collected packages: jsonschema, functools32 03:51:13 INFO - Running setup.py install for functools32 03:51:13 INFO - warning: no files found matching '*.txt' 03:51:13 INFO - no previously-included directories found matching 'build' 03:51:13 INFO - no previously-included directories found matching 'dist' 03:51:13 INFO - no previously-included directories found matching '.git*' 03:51:13 INFO - Successfully installed jsonschema functools32 03:51:13 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:14 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 03:51:14 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 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:14 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:14 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 03:51:14 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 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:16 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 03:51:17 INFO - Downloading docopt-0.6.1.tar.gz 03:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:17 INFO - Running setup.py install for blobuploader 03:51:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:17 INFO - Running setup.py install for requests 03:51:17 INFO - Running setup.py install for docopt 03:51:17 INFO - Successfully installed blobuploader requests docopt 03:51:17 INFO - Cleaning up... 03:51:17 INFO - Return code: 0 03:51:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:17 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 03:51:17 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 03:51:17 INFO - Using env: {'DISPLAY': ':0', 03:51:17 INFO - 'HOME': '/home/cltbld', 03:51:17 INFO - 'LANG': 'en_US.UTF-8', 03:51:17 INFO - 'LANGUAGE': 'en_US:en', 03:51:17 INFO - 'LOGNAME': 'cltbld', 03:51:17 INFO - 'MAIL': '/var/mail/cltbld', 03:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:17 INFO - 'MOZ_NO_REMOTE': '1', 03:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:17 INFO - 'NO_EM_RESTART': '1', 03:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:17 INFO - 'PWD': '/builds/slave/test', 03:51:17 INFO - 'SHELL': '/bin/bash', 03:51:17 INFO - 'SHLVL': '1', 03:51:17 INFO - 'TERM': 'linux', 03:51:17 INFO - 'TMOUT': '86400', 03:51:17 INFO - 'USER': 'cltbld', 03:51:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:17 INFO - '_': '/tools/buildbot/bin/python'} 03:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:17 INFO - Running setup.py (path:/tmp/pip-zxG0ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:18 INFO - Running setup.py (path:/tmp/pip-AgmvKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:18 INFO - Running setup.py (path:/tmp/pip-ae6_vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:18 INFO - Running setup.py (path:/tmp/pip-FiKrAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:18 INFO - Running setup.py (path:/tmp/pip-H96B9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:18 INFO - Running setup.py (path:/tmp/pip-3Tqd8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:18 INFO - Running setup.py (path:/tmp/pip-zHOPCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:18 INFO - Running setup.py (path:/tmp/pip-MRk07R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:18 INFO - Running setup.py (path:/tmp/pip-5pend0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:18 INFO - Running setup.py (path:/tmp/pip-aFJ_KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:18 INFO - Running setup.py (path:/tmp/pip-Ab6_oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:18 INFO - Running setup.py (path:/tmp/pip-vElGRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:18 INFO - Running setup.py (path:/tmp/pip-QBeRgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:18 INFO - Running setup.py (path:/tmp/pip-BrJII2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:18 INFO - Running setup.py (path:/tmp/pip-xfKwC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:19 INFO - Running setup.py (path:/tmp/pip-cxGo_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:19 INFO - Running setup.py (path:/tmp/pip-JEomS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:19 INFO - Running setup.py install for manifestparser 03:51:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Running setup.py install for mozcrash 03:51:19 INFO - Running setup.py install for mozdebug 03:51:19 INFO - Running setup.py install for mozdevice 03:51:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Running setup.py install for mozfile 03:51:19 INFO - Running setup.py install for mozhttpd 03:51:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Running setup.py install for mozinfo 03:51:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Running setup.py install for mozInstall 03:51:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Running setup.py install for mozleak 03:51:20 INFO - Running setup.py install for mozlog 03:51:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Running setup.py install for moznetwork 03:51:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Running setup.py install for mozprocess 03:51:20 INFO - Running setup.py install for mozprofile 03:51:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Running setup.py install for mozrunner 03:51:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Running setup.py install for mozscreenshot 03:51:20 INFO - Running setup.py install for moztest 03:51:20 INFO - Running setup.py install for mozversion 03:51:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:20 INFO - Cleaning up... 03:51:20 INFO - Return code: 0 03:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:20 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:20 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 03:51:20 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 03:51:20 INFO - Using env: {'DISPLAY': ':0', 03:51:20 INFO - 'HOME': '/home/cltbld', 03:51:20 INFO - 'LANG': 'en_US.UTF-8', 03:51:20 INFO - 'LANGUAGE': 'en_US:en', 03:51:20 INFO - 'LOGNAME': 'cltbld', 03:51:20 INFO - 'MAIL': '/var/mail/cltbld', 03:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:20 INFO - 'MOZ_NO_REMOTE': '1', 03:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:20 INFO - 'NO_EM_RESTART': '1', 03:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:20 INFO - 'PWD': '/builds/slave/test', 03:51:20 INFO - 'SHELL': '/bin/bash', 03:51:20 INFO - 'SHLVL': '1', 03:51:20 INFO - 'TERM': 'linux', 03:51:20 INFO - 'TMOUT': '86400', 03:51:20 INFO - 'USER': 'cltbld', 03:51:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:20 INFO - '_': '/tools/buildbot/bin/python'} 03:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:21 INFO - Running setup.py (path:/tmp/pip-Y9LVMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:21 INFO - Running setup.py (path:/tmp/pip-jBDQfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:21 INFO - Running setup.py (path:/tmp/pip-TWOlCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:21 INFO - Running setup.py (path:/tmp/pip-JYlcB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:21 INFO - Running setup.py (path:/tmp/pip-SCOLxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:21 INFO - Running setup.py (path:/tmp/pip-TVTe7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:21 INFO - Running setup.py (path:/tmp/pip-3uLMpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:21 INFO - Running setup.py (path:/tmp/pip-xZcggV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:21 INFO - Running setup.py (path:/tmp/pip-3BPbR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:21 INFO - Running setup.py (path:/tmp/pip-UxL_Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:21 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)) 03:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:21 INFO - Running setup.py (path:/tmp/pip-VHAbkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:22 INFO - Running setup.py (path:/tmp/pip-qNbZZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:22 INFO - Running setup.py (path:/tmp/pip-UgpIlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:22 INFO - Running setup.py (path:/tmp/pip-po6GSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:22 INFO - Running setup.py (path:/tmp/pip-AebMWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:22 INFO - Running setup.py (path:/tmp/pip-xalBwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:22 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)) 03:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:22 INFO - Running setup.py (path:/tmp/pip-2ecbj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:22 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)) 03:51:22 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)) 03:51:22 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)) 03:51:22 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)) 03:51:22 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)) 03:51:22 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)) 03:51:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:24 INFO - Downloading blessings-1.6.tar.gz 03:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:24 INFO - Installing collected packages: blessings 03:51:24 INFO - Running setup.py install for blessings 03:51:24 INFO - Successfully installed blessings 03:51:24 INFO - Cleaning up... 03:51:24 INFO - Return code: 0 03:51:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:24 INFO - Reading from file tmpfile_stdout 03:51:24 INFO - Current package versions: 03:51:24 INFO - argparse == 1.2.1 03:51:24 INFO - blessings == 1.6 03:51:24 INFO - blobuploader == 1.2.4 03:51:24 INFO - docopt == 0.6.1 03:51:24 INFO - functools32 == 3.2.3-2 03:51:24 INFO - jsonschema == 2.5.1 03:51:24 INFO - manifestparser == 1.1 03:51:24 INFO - mozInstall == 1.12 03:51:24 INFO - mozcrash == 0.17 03:51:24 INFO - mozdebug == 0.1 03:51:24 INFO - mozdevice == 0.48 03:51:24 INFO - mozfile == 1.2 03:51:24 INFO - mozhttpd == 0.7 03:51:24 INFO - mozinfo == 0.9 03:51:24 INFO - mozleak == 0.1 03:51:24 INFO - mozlog == 3.3 03:51:24 INFO - moznetwork == 0.27 03:51:24 INFO - mozprocess == 0.23 03:51:24 INFO - mozprofile == 0.28 03:51:24 INFO - mozrunner == 6.12 03:51:24 INFO - mozscreenshot == 0.1 03:51:24 INFO - mozsystemmonitor == 0.3 03:51:24 INFO - moztest == 0.7 03:51:24 INFO - mozversion == 1.4 03:51:24 INFO - psutil == 3.1.1 03:51:24 INFO - requests == 1.2.3 03:51:24 INFO - wsgiref == 0.1.2 03:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:24 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:24 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 03:51:24 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 03:51:24 INFO - Using env: {'DISPLAY': ':0', 03:51:24 INFO - 'HOME': '/home/cltbld', 03:51:24 INFO - 'LANG': 'en_US.UTF-8', 03:51:24 INFO - 'LANGUAGE': 'en_US:en', 03:51:24 INFO - 'LOGNAME': 'cltbld', 03:51:24 INFO - 'MAIL': '/var/mail/cltbld', 03:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:24 INFO - 'MOZ_NO_REMOTE': '1', 03:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:24 INFO - 'NO_EM_RESTART': '1', 03:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:24 INFO - 'PWD': '/builds/slave/test', 03:51:24 INFO - 'SHELL': '/bin/bash', 03:51:24 INFO - 'SHLVL': '1', 03:51:24 INFO - 'TERM': 'linux', 03:51:24 INFO - 'TMOUT': '86400', 03:51:24 INFO - 'USER': 'cltbld', 03:51:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:24 INFO - '_': '/tools/buildbot/bin/python'} 03:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 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)) 03:51:24 INFO - Cleaning up... 03:51:25 INFO - Return code: 0 03:51:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:25 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 0x216b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, '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': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', '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 03:51:25 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 03:51:25 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 03:51:25 INFO - Using env: {'DISPLAY': ':0', 03:51:25 INFO - 'HOME': '/home/cltbld', 03:51:25 INFO - 'LANG': 'en_US.UTF-8', 03:51:25 INFO - 'LANGUAGE': 'en_US:en', 03:51:25 INFO - 'LOGNAME': 'cltbld', 03:51:25 INFO - 'MAIL': '/var/mail/cltbld', 03:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:25 INFO - 'MOZ_NO_REMOTE': '1', 03:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:25 INFO - 'NO_EM_RESTART': '1', 03:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:25 INFO - 'PWD': '/builds/slave/test', 03:51:25 INFO - 'SHELL': '/bin/bash', 03:51:25 INFO - 'SHLVL': '1', 03:51:25 INFO - 'TERM': 'linux', 03:51:25 INFO - 'TMOUT': '86400', 03:51:25 INFO - 'USER': 'cltbld', 03:51:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:25 INFO - '_': '/tools/buildbot/bin/python'} 03:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:25 INFO - Cleaning up... 03:51:25 INFO - Return code: 0 03:51:25 INFO - Running post-action listener: _resource_record_post_action 03:51:25 INFO - Running post-action listener: _start_resource_monitoring 03:51:25 INFO - Starting resource monitoring. 03:51:25 INFO - [mozharness: 2016-07-30 10:51:25.269734Z] Finished create-virtualenv step (success) 03:51:25 INFO - [mozharness: 2016-07-30 10:51:25.270174Z] Running install step. 03:51:25 INFO - Running pre-action listener: _resource_record_pre_action 03:51:25 INFO - Running main action method: install 03:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:25 INFO - Reading from file tmpfile_stdout 03:51:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:25 INFO - Reading from file tmpfile_stdout 03:51:25 INFO - Output received: 03:51:25 INFO - Usage: mozinstall [options] installer 03:51:25 INFO - Options: 03:51:25 INFO - -h, --help show this help message and exit 03:51:25 INFO - -d DEST, --destination=DEST 03:51:25 INFO - Directory to install application into. [default: 03:51:25 INFO - "/builds/slave/test"] 03:51:25 INFO - --app=APP Application being installed. [default: firefox] 03:51:25 INFO - mkdir: /builds/slave/test/build/application 03:51:25 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'] 03:51:25 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 03:51:41 INFO - Reading from file tmpfile_stdout 03:51:41 INFO - Output received: 03:51:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:41 INFO - Running post-action listener: _resource_record_post_action 03:51:41 INFO - [mozharness: 2016-07-30 10:51:41.577616Z] Finished install step (success) 03:51:41 INFO - [mozharness: 2016-07-30 10:51:41.577898Z] Running run-tests step. 03:51:41 INFO - Running pre-action listener: _resource_record_pre_action 03:51:41 INFO - Running main action method: run_tests 03:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:41 INFO - Python 2.7.3 03:51:41 INFO - Return code: 0 03:51:41 INFO - grabbing minidump binary from tooltool 03:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:41 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 0x242a3b0>, '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 0x242b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:41 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 03:51:41 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 03:51:41 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 03:51:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:41 INFO - Return code: 0 03:51:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 03:51:41 INFO - Using env: {'DISPLAY': ':0', 03:51:41 INFO - 'HOME': '/home/cltbld', 03:51:41 INFO - 'LANG': 'en_US.UTF-8', 03:51:41 INFO - 'LANGUAGE': 'en_US:en', 03:51:41 INFO - 'LOGNAME': 'cltbld', 03:51:41 INFO - 'MAIL': '/var/mail/cltbld', 03:51:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:41 INFO - 'MOZ_NO_REMOTE': '1', 03:51:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:41 INFO - 'NO_EM_RESTART': '1', 03:51:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:41 INFO - 'PWD': '/builds/slave/test', 03:51:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:41 INFO - 'SHELL': '/bin/bash', 03:51:41 INFO - 'SHLVL': '1', 03:51:41 INFO - 'TERM': 'linux', 03:51:41 INFO - 'TMOUT': '86400', 03:51:41 INFO - 'USER': 'cltbld', 03:51:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278', 03:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:41 INFO - '_': '/tools/buildbot/bin/python'} 03:51:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:51:41 INFO - mozversion application_buildid: 20160730005025 03:51:41 INFO - mozversion application_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 03:51:41 INFO - mozversion application_display_name: Nightly 03:51:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:41 INFO - mozversion application_name: Firefox 03:51:41 INFO - mozversion application_remotingname: firefox 03:51:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:51:41 INFO - mozversion application_vendor: Mozilla 03:51:41 INFO - mozversion application_version: 50.0a1 03:51:41 INFO - mozversion platform_buildid: 20160730005025 03:51:41 INFO - mozversion platform_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 03:51:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:51:41 INFO - mozversion platform_version: 50.0a1 03:51:41 INFO - using testdate: 1469875901 03:51:41 INFO - actual date: 1469875901 03:51:41 INFO - starting webserver on 'localhost:45608' 03:51:41 INFO - SUITE-START | Running 2 tests 03:51:41 INFO - TEST-START | dromaeo_css 03:51:41 INFO - operating with platform_type : linux_ 03:51:41 INFO - Initialising browser for dromaeo_css test... 03:51:41 INFO - TEST-INFO | started process 16716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahv8oQ/profile http://localhost:45608/getInfo.html) 03:51:46 INFO - PROCESS | 16716 | __metrics Screen width/height:1600/1200 03:51:46 INFO - PROCESS | 16716 | colorDepth:24 03:51:46 INFO - PROCESS | 16716 | Browser inner width/height: 1024/697 03:51:46 INFO - PROCESS | 16716 | __metrics 03:51:47 INFO - PROCESS | 16716 | 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" 03:51:47 INFO - PROCESS | 16716 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:51:48 INFO - TEST-INFO | 16716: exit 0 03:51:48 INFO - Browser initialized. 03:51:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:48 INFO - TEST-INFO | started process 16796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahv8oQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:00 INFO - PROCESS | 16796 | RSS: Main: 157159424 03:52:00 INFO - PROCESS | 16796 | 03:52:51 INFO - PROCESS | 16796 | 1469875971460 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] 03:55:04 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45608/tests/dromaeo/cssquery-ext.html) 03:55:05 INFO - PROCESS | 16796 | RSS: Main: 274026496 03:55:05 INFO - PROCESS | 16796 | 03:58:08 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-ext.html (next: http://localhost:45608/tests/dromaeo/cssquery-jquery.html) 03:58:08 INFO - PROCESS | 16796 | RSS: Main: 244867072 03:58:08 INFO - PROCESS | 16796 | 04:01:11 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45608/tests/dromaeo/cssquery-mootools.html) 04:01:11 INFO - PROCESS | 16796 | RSS: Main: 181805056 04:01:11 INFO - PROCESS | 16796 | 04:04:13 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45608/tests/dromaeo/cssquery-prototype.html) 04:04:14 INFO - PROCESS | 16796 | RSS: Main: 183984128 04:04:14 INFO - PROCESS | 16796 | 04:07:17 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45608/tests/dromaeo/cssquery-yui.html) 04:07:18 INFO - PROCESS | 16796 | RSS: Main: 184037376 04:07:18 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:45608/tests/dromaeo/cssquery-yui.html (next: http://localhost:45608/tests/dromaeo/cssquery-dojo.html) 04:10:21 INFO - PROCESS | 16796 | RSS: Main: 278323200 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | __start_tp_report 04:10:21 INFO - PROCESS | 16796 | _x_x_mozilla_page_load 04:10:21 INFO - PROCESS | 16796 | _x_x_mozilla_page_load_details 04:10:21 INFO - PROCESS | 16796 | |i|pagename|runs| 04:10:21 INFO - PROCESS | 16796 | |0;dojo.html;2661.4277930244994;2668.546347120992;2687.9999999999995;2714.674239091308;2720.918372448826;4640.628749700024;4763.690360126589;4799.7360145192;4830.516948305168;4848.975755121228;4755.476897541268;4760.381150450446;4794.089123066615;4823.614110871131;4874.268859671051;4422.469303683562;4447.57748013939;4468.932966005513;4481.148581769454;4602.286645569942;4565;4566.246569316058;4570.588647021767;4571.3143028545655;4587.0596527711905;4353.5428779977965;4391.692581519295;4418.072204836988;4472.217361961643;4476.104779044204;4465.9106817863785;4475.373447717322;4475.77621118946;4477.1493416250805;4479.529649386833;4356.106998065389;4403.097365040191;4428.357888106207;4435.62297204738;4503.887402814923;4743.667943243974;4807.831725889577;4810.518948105197;4888.682235654706;4911.803527858881;5200.29795977542;5235.345581802275;5252.369715634149;5253.08071087562;5254.737263136828;4967.7764500597195;5035.823746168903;5049.873753156164;5155.922661160085;5254.579633629301;4827.058723548945;4895.265710143507;4912.091263116335;4915.361003069578;4920.6309526785635;5349.1976203569775;5355.30381050461;5426.538744206787;5431.402545719968;5432.483914028161;4905.558499735041;5064.594832413398;5070.721110338893;5182.24857395683;5188.558972487305;5236.136037553837;5279.234510995884;5282.894342113136;5285.2600635911;5289.894202116013;5083.389993200765;5128.282040514331;5135.7432128394175;5194.610404219623;5242.108841496878;4867.172580661296;4997.175466048134;5073.568746656501;5104.1067813133295;5158.97420512895;4425.849279187434;4426.75652839097;4451.688381813242;4464.374987501752;4464.866054018385;3871.2257548490416;3894.357431023906;3895.7662540247675;3919.5884432134217;3947.5657677655436;4368.060866913629;4429.15845989261;4462.888427789331;4548.226801443762;4555.977220113945;5143.099957507421;5168.560672342893;5195.558377537952;5235.816746413857;5243.397009343974;4494.865154045384;4525.162844873709;4533.433320834895;4538.160440318552;4585.770711464414;4565.497795242521;4676.251799712029;4710.601091808429;4733.881652958704;4768.141734487756;4920.778564964514;4976.377952755905;4981.6014718823135;5022.422421421583;5024.321716568216;5238.947610523846;5242.056429842665;5255.421903590525;5264.368275806928;5301.549368303583;4757.5718185363485;4854.417469903634;4975.50244975514;4982.302477653204;4983.875403114951;5033.094043072282;5035.974820125876;5038.874028149326;5090.592752579711;5096.949030509648;5103.923441148311;5111.309973153577;5111.872203194801;5116.181410974226;5165.431802501646;4737.952620473751;4826.927596085991;4922.064807686528;4922.163232250455;4927.778249978688;5045.4450010498085;5076.416212135652;5085;5106.948930510647;5129.128048231884;5006.774695138801;5008.273800299009;5026.899462010812;5054.317667114892;5061.772220250171;4885.5847252983895;5018.799248030038;5091.974540127276;5102.770375333193;5111.667741596784;4938.209886418156;4938.43208031081;4970.204767237225;5010.448850626501;5029.698218106925 04:10:21 INFO - PROCESS | 16796 | |1;ext.html;548.5976934803057;579.1110645159681;590.5659340384819;592.4371846745587;596.4244504053587;26787.464250714973;37564.62435375645;38849.61150388495;38853.417198742005;38868.80565597168;40432.797836010854;40865;40952.18095638086;40958.795206023926;40978.38532422016;7515.736949206779;7717.305442510173;7860.764177074697;7871.567063811488;9868.753281167992;9710.563024663907;10113.89886101137;10120.291579589431;10127.645532406368;10131.949340253324;10159.796804063913;10177.134943529809;10214.795704085915;10225.590976360936;10242.385456872611;10097.293189476739;10099.29304948654;10169.898301017007;10174.796504069951;10176.542055607515;9965.252606054502;10016.298859079867;10023.59905603775;10033.49832508379;10038.046385593358;37950;38404.42393364102;38421;38426.80786596077;38440.80779596084;3076.3539656672124;3102.3329984053535;3151.6848315168527;3343.36476069546;3465.4108801503803;28986.27534311638;29036.27409314763;29612.111636650934;29685.406291874257;29782.02179782026;2852.82883027017;2930.340673348501;2957.6746557878614;3020.9244768880735;3027.455058089543;250827;251666;251946;251957;253126;51514.48485515172;51654.22518662223;51766.74116629393;51983.48016519786;52044.73977630088;32197.195070123435;54914.450855491734;54916.45083549193;55104.448955509935;55106.44893551013;14212.928935355258;14932.776008359884;14963.775543366859;14990.250487475583;15025.699486010219;9364.25085993119;11369.602063927723;11684;11870.881291186977;11993.760124797454;17967.73048404275;17977.730334044998;18018.459446216635;18024.188911499015;18140.002299873635;5390.568754499631;6945.548539344926;6952.478564107712;7003.968849033825;7224.277572242839;766.2567309709573;809.7773112394138;880.5377176982136;898.4833720610544;934.56075644447;27126.86436567844;28196.577051344248;28702.85648571744;28922.710772892424;28925.85537072343;932.7061975477703;965.6137544982064;976.3165783951263;1033.5968972100886;1036.429963520061;14304.356303966139;14885.479008234659;15046.623834404008;15288.770668439982;15302.387904483918;401690;403697;404597;406221;406968;48853.02293954172;49201;49501.75249123803;49518.75240623846;49628.75185624049;1063.7500187455942;1143.2968724234536;1154.318951818431;1182.4501606752558;1204.7710934922336;27602.585961210196;28727.71272287334;29314.267143321587;29438.558421623264;29645.25886852846;41611.16777664369;42140;42140;42165.367519486615;42224.78887605542;303349;303402;303810;304045;304202;24001.27996160118;25195.370115747253;25248.873755631103;26432.471350573265;26671.33321666974;40803.7959810199;40950.59049409468;41560.79219603883;41780;45841;35207.47188792119;35679.464808027384;36239;39182.84494352838;40072.198556029296;35961.28077438489;36162;36582.26835463329;36775.26449471049;37227.441588376736;35080.12299692528;35246.64753352434;35299.82350088336;35747;36546.8172659135;30941.69058309478;32733.18167045843;32735.508967365033;32908.34183316368;33034.33931321312;24618.630720539564;25177.370565736004;25239;25357.61963570511;25493.107741228967 04:10:21 INFO - PROCESS | 16796 | |2;jquery.html;356.1647935591038;373.121299340054;380.1124374585344;382.5772521363893;391.0829105747022;12341.899069735595;12792.232466052032;17200.655986880287;17218.39735609254;17254.741178882326;16267.267972941216;16698.415555455562;16934.06862622555;16970.915145424286;17072.658546829058;3733.850645974158;4847.757612119389;5038.571721403685;5041.369828771403;5043.621728370368;5609.439056094398;5830.912536311958;5916.940830591703;6020.969895150518;6028.336882942873;5071.594272458213;5377.4084850666595;5913.674747888865;5981.342052374235;5992.280926288851;5391.514763671269;5419.403865574784;5424.240606315119;5430.185472179165;5430.782768689248;4757.881052973668;4997.05056039355;5030.446650868402;5247.1866860636665;5261.7369131543655;12427.3786310685;12631.621051368473;12702.491900323976;12709.364531773466;19049.80950190508;1800.0369802155915;1812.2298023340027;1839.1356062650532;1997.0913234478278;2241.4620491082187;8420.494770313739;8576.485410875368;8866.42368246062;9083;9091.863622045674;1599.3043026283603;1658.4361317152227;1688.6031782531095;1745.2844333823073;1781.7594624725755;63891.68054159746;67998.66000669965;69025;69522.30477695209;70898.64550677265;9986.950065249628;10158.104940092038;10274.845877311845;10408.531616077144;10421.9478902605;14253.643658908402;14269.714605708035;14270.643233919027;14284.785728214085;14290.42838286457;7356.485046046832;7491.737789177461;7508.924910750932;7573.886391704129;7709.575973321409;7126.714931402686;7153.248908864598;7309.817254568572;7359.448041396917;7370.926290737024;4280;4382.561743825592;4410.867673969786;4491;4524.343970124313;1554.4947891935167;1659.6348803263263;1785.7946336171506;1907.809219078081;1914.5022294203607;786.4101923557332;806.9959650201829;810.6473683947502;849.3375167369462;851.5912362066243;16155.353785848434;16275.186240687919;17047.91476042612;17572.560685982953;17689.380871669688;799.2926260259596;832.3299743706253;847.7329641163014;877.1886005444937;878.7056336127469;9010.684626038057;9765.316427850124;9802.5588848502;9824.607015719434;9842.950785246028;377196;381183;400091;401728;402163;53081.46918530765;79500.60249698715;80120.59939700265;81180.59409702914;85007.5749621248;842.8272204198247;915.6657819895823;956.4691596164196;973.776031512756;978.1734434402919;13872.514461993782;14563.41746330135;14820.851791481948;15834.841651583336;15915.840841591436;35322.47016294809;37203.255934881694;37312.07879730478;39257;39620.801895990335;52574;52710.519605833935;53131.73434132805;54949.725251373486;54991;7293.452991025801;7351.3751331137455;7394;7440.962795185989;7641.7707468776025;8653.437526560754;11019.889801102207;11538.653840384803;11544.017314026647;12571.685707857378;10455.94772026135;10575.841362379724;10580.788384232426;10676.83984740214;10736.141108711441;10726.839097413702;10784.460776960963;10813.999410109154;10852.186086043735;11165.330080195214;10398.532066056894;10690.572377104829;10833.512491937725;10949.124070074535;11189.944050280023;7541.7360392386;7575.583342916192;7830.76507704747;7995.240452157036;8063.83872322562;9625.32622716403;10160.593576256866;10264.178865690876;10388.896111039096;10674.199435042248 04:10:21 INFO - PROCESS | 16796 | |3;mootools.html;1337.5920344294989;1370.6504841265476;1489.2107183192904;1689.0625702734976;1700.2773821126011;7696.153423123459;8240.917590824098;8250.133735957728;8251;8259.834803303931;6959.652017399122;7680.807979800507;7912.287894089531;7917.406194535419;8084.191580841913;2231.520223152026;2233.7877901599322;2248.3367406615007;2254.0532976150057;2262.332611879491;2204.548067646129;2214.966775498369;2257.255105815077;2278.5329007553496;2283.0068920019844;2263.298377502971;2268.7958083772455;2275.5221403505284;2278.1456953642382;2291.2897001929373;2142.368001439579;2153.386284908809;2157.083239623154;2159.654455287154;2171.9457013574706;2159.492519257973;2160.362693005567;2165.7184566006476;2166.566686662658;2168.5988092202992;8099.95950020252;8101.878471822927;8158.755237342889;8177.304929081035;8179.672813087469;4713.6936099153445;4838.903221935541;4842.757862106881;4853.854384368475;4855.295982082578;2893.652761668613;3041.8022828516296;3043.9391212175856;3049.786514943955;3051.359214564944;867.6182479708971;911.3893691226893;920.2775820980498;921.1939552891221;937.3485427627801;10957.397343146124;10983.066439352664;10993.065589424908;10996.890031099747;11005.339679619248;4144.191882582867;4391.945932976127;4467.039586488921;4472.763618190905;4494.1461122386645;9506.524673766284;9512.04879512057;9516.429014259167;9519.333646644669;9523.761905952268;4841.12859685253;4850.781714822841;4880.487548807395;4883.487233840467;4890.339804126468;3824.0631045394057;4197.601227883346;4384.079343337871;4430.534793846599;4441.71128876622;3768.2651882883124;3789.8673546426294;3912.256671232514;3932.0956180078742;3946.940795888064;1208.0818577880698;1247.357610830423;1251.599488163797;1257.8993680505537;1263.3935710858839;805.8549461096942;826.0376661189766;828.5608627427473;837.351052933981;840.3907167303778;5321.388040375329;5332.226827110047;5343.3587969443915;5408.45915408456;5469.671819690831;869.8477766390982;873.9949058582554;880.5113162195044;897.7845317123974;905.5291248550849;3572.339117263263;3572.517710109154;3642.7267954903486;3646.033801042726;3662.230931504361;9289.814203716023;9763.316567840184;10047.447390393452;10194.133498652549;10215.978402159724;9890.159336456481;10031.398116113056;10104.393736375841;10169.745756356151;10185.981401859755;7518.962405187939;7660.61696915152;7662.999999999888;7663.463557551029;7668.271514206142;5197.272381866617;5201.791928322825;5230.241614965733;5237.790488380575;5260.9736951315;9079.500627465553;9102.863457048283;9108.772280693036;9134.314926380415;9183.862242066241;9090;9366.859497107685;9418.481983490974;9469.195118414736;9472.715818525456;5966.224390829165;6590.209174899042;6756.594604323756;6764.188297404343;7189.496735228484;7500.174980752222;7633.2366763323225;7797.844043118992;7801.609919503889;7811.531308121531;6720.193576770819;6867.175938887166;6912.27421120775;6978.720851166099;7105.18290396611;6651.501137414616;6697.464202863662;6735.461163106842;6806.115205023315;6964.582125072512;6283.654399007915;6341.175647165839;6385.393387628168;6393.1688880445245;6402.647854368054;4269.4449721536;4275.893102672458;4521.683482156349;4525.230710779109;4567.931481027721;4426.822927082881;4514.796834142538;4534.365188873494;4643.582077613031;4772.331873537777 04:10:21 INFO - PROCESS | 16796 | |4;prototype.html;303.18594573569965;308.426327031721;313.06081754735794;313.3904555639281;317.6061683512444;4872.75636218189;4883.584895283901;4892.608591312695;4898.975505122469;4902.632302577304;4803.759812009394;4808.519148085198;4815.735134567597;4818.349522814419;4834.613230941516;3620.3664358737183;3767.2465506898593;3790.4314352847155;3844.826982785781;3845.6923446124383;3808.847646094153;3846.2307538492273;3877.8836634901;3887.280853042196;3891.9805400972955;3806.7437745544044;3811.9517132788565;3816.618338166175;3824.120452295974;3833.9041523961846;3555.8044307563073;3669.302832461837;3744.4383342498845;3797.810109494542;3834.8657796977113;3304.9173770655925;3341.665833416663;3342.4819153031317;3352.2122301259183;3361.445361515347;4732.550407711262;4769.332293478881;4770.642201834877;4790.209615413452;4815.783289751969;4172;4351.6518678505645;4367.410399596078;4369.410129632491;4375.6937014409;5031.861458879998;5042.20157812414;5043.167877300241;5049.974750126225;5056.772445239973;3663.19409729859;3679.981600092009;3690.760100593453;3695.1870588470492;3697.2605478904325;5023.924641130349;5290.735463226823;5314.574834013309;5360.839174824722;5374.677519348852;3768.5289338832645;3798.3732684106812;3848.461215429842;3851.383778595411;3857.360621735751;3913.178232571192;3926.784026878549;3930.705197110171;3936.704747143918;3953.940690889639;4417.337399390117;4422.673198040575;4445.399226626443;4451.863105709278;4465.972826249981;4962.057209130254;5092.541671249605;5117.334746483008;5130.461301563282;5142.897142057138;1333.8732820382047;1341.5438750824571;1343.1806597975228;1352.6550729563899;1356.5184359552413;857.0229937870832;882.4572887674162;898.4905358996948;900.1628485508539;902.8106840910896;4159.812808423628;4396.626286765597;4476.6418686505;4567.3377360282575;4571.22289210835;5178.922316165261;5207.973960130251;5221.295125158055;5249;5255.737213139328;4542.863714088583;4558.88602784933;4562.110388474216;4574.290984897346;4598.3329668792685;2653.509100816355;2774.722527747209;2777.291790593386;2782.65216847894;2784.693683694792;4982.352294201731;4991.925121123186;5002.1496345621335;5004.799808007711;5020.146575082244;5198.012377648235;5361.919571206435;5370.650907690988;5390.460953904578;5392.703401312965;4938.333325001079;4953.331300274489;4968.354113965162;4975.676581022294;5000.824971126066;5252.527272545489;5252.684838909678;5253.658512196695;5266.762995665281;5286.15421532553;4926.5073492650445;5152.793888244429;5156.664816786897;5226.973865130803;5235.685858848481;5016.448190699093;5048.62714524173;5053.772580233972;5062.443131255633;5070.138076526926;3745.9063523412133;3755.3240416725253;3764.661180493769;3792.8672496463596;3802.6007269236334;5060.797568097235;5349.411564727799;5360.579446446773;5361.303030605996;5374.57003439716;5035.647504674637;5045.596352291735;5047.2429135629945;5052.444231134646;5066.240063990431;5103.515166059218;5109.821156259513;5115.846524604268;5121.231815227746;5141.511556402136;4862.562369386631;4977.9502204978935;5046.545810876892;5066.341375621146;5088.338515992898;4891.5353041461;5013.2981382607195;5095.414027386898;5097.9490205098955;5123.180291153398;4814.5907597853175;4915.557599816034;4923.236898280772;4934.679245849008;4951.851444456672 04:10:21 INFO - PROCESS | 16796 | |5;yui.html;588.6997631208084;621.6363427394974;650.7071817682045;671.5232185148543;686.3068301015976;11426.257293275941;11984.041276697864;12000.339981301036;12391.566295179671;12417.813732793993;12202.206856554318;12260.448279827408;12298.446569904354;12570.30863302518;13271.668208294797;742.6620887496176;777.3276116159537;782.2881178127905;782.4092809928525;782.7299581644323;771.4291424346;773.8993930789018;773.97678069658;774.4462709162948;774.6978678315461;813.8860559521672;815.8653822119343;816.0207750699155;816.1919699497485;816.346922462031;808.462372522272;808.7614153824636;809.6154326694802;809.6963638635511;810.0117856215437;594.3046635436507;594.7829042399493;594.8156071617813;594.8423667728056;594.8691287916652;12639.925606323473;12651.683707907285;12680.492780288778;12682.492700291978;12692.873071269261;11795.94102029493;11909.404529773563;12183.878161218363;12319.5072197112;13045.152065115832;9929.106380425725;9970.252231082697;9976;10286.074253317163;10436.791264174673;3117.08046126391;3156.1478400831875;3168.683131686813;3182.0931034655014;3274.361499507597;60313.69843150756;60814;61279.387206127816;61750.69124654348;62060.68969655168;8975.640974360953;9057.501837399006;9193;9200.171984521425;9215.723528294027;16089.758653620205;16356.263968121462;16367.345306187857;16534.917325413535;16537.338506459608;6717.56335838169;6732.899006514906;6873.862522749517;6908.067410899464;6932.44540436774;3540.5220295260324;3587.2287458196615;3618.095476130967;3652;3662.102784817737;2775.417162395879;2870.72728090831;2872.6409198850142;2874.453853767777;2896.841263494619;496.9304297398367;506.39232920494817;508.6464906889676;509.41671785805045;514.1901505129437;544.2435015328696;587.3597778421541;591.4499515450672;597.128192838452;597.7250464786247;7663.348615367645;7757.146713861471;7798.610069496503;7822.569758663214;7916;550.9531689806331;561.6433564686454;573.2118337286231;575.9625624334404;585.1456872965433;3352;3523.436250199956;3600.2439487707875;3637.0907273181706;3706.3328600852105;90259.54870225738;91277.33894335717;91977;93123.53438232765;93542;55766;71134;71264.64367678128;78621.60689196517;82887.17112828915;60673;62325.37674623286;64158.35841641524;72445.6377718108;72545.6372718133;7883.329916956894;8339.708110216114;8355.874661880198;8398.958005209935;8524.104968978416;32232;40757.59242407538;44251.55748442603;44758;47485.96369308647;58800;60471.697641513274;60812;60921.39078609157;63501;10224.488775561043;10228.232882533692;10250.743731406774;10702.09032232269;10970.341779493256;11469.541218351173;11898.940505297418;12052.276863388224;12534.811977820522;12941.935290323489;9955.601775929172;10191.94904025475;10267.58929642806;10849.620263290746;11258.324500529994;11309.377984210947;11700.648980530597;11740.82591740819;11831.52673893069;12460.626181214579;11235.269707469315;11622.244554103956;11954.103442241692;12038.03695704359;12042.63872083839;8985.312086980426;9132.908670913206;9330.066993300887;9604.186592793414;9877.456739879375;8683;9181.540922953693;9214.723558293263;9299.907000929905;9363.110504502061 04:10:21 INFO - PROCESS | 16796 | __end_tp_report 04:10:21 INFO - PROCESS | 16796 | __start_cc_report 04:10:21 INFO - PROCESS | 16796 | _x_x_mozilla_cycle_collect,1143 04:10:21 INFO - PROCESS | 16796 | __end_cc_report 04:10:21 INFO - PROCESS | 16796 | __startTimestamp1469877021345__endTimestamp 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | ------- Summary: start ------- 04:10:21 INFO - PROCESS | 16796 | Number of tests: 6 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#0] dojo.html Cycles:165 Average:4795.54 Median:4920.78 stddev:498.68 (10.1%) stddev-sans-first:471.27 04:10:21 INFO - PROCESS | 16796 | Values: 2661.4 2668.5 2688.0 2714.7 2720.9 4640.6 4763.7 4799.7 4830.5 4849.0 4755.5 4760.4 4794.1 4823.6 4874.3 4422.5 4447.6 4468.9 4481.1 4602.3 4565.0 4566.2 4570.6 4571.3 4587.1 4353.5 4391.7 4418.1 4472.2 4476.1 4465.9 4475.4 4475.8 4477.1 4479.5 4356.1 4403.1 4428.4 4435.6 4503.9 4743.7 4807.8 4810.5 4888.7 4911.8 5200.3 5235.3 5252.4 5253.1 5254.7 4967.8 5035.8 5049.9 5155.9 5254.6 4827.1 4895.3 4912.1 4915.4 4920.6 5349.2 5355.3 5426.5 5431.4 5432.5 4905.6 5064.6 5070.7 5182.2 5188.6 5236.1 5279.2 5282.9 5285.3 5289.9 5083.4 5128.3 5135.7 5194.6 5242.1 4867.2 4997.2 5073.6 5104.1 5159.0 4425.8 4426.8 4451.7 4464.4 4464.9 3871.2 3894.4 3895.8 3919.6 3947.6 4368.1 4429.2 4462.9 4548.2 4556.0 5143.1 5168.6 5195.6 5235.8 5243.4 4494.9 4525.2 4533.4 4538.2 4585.8 4565.5 4676.3 4710.6 4733.9 4768.1 4920.8 4976.4 4981.6 5022.4 5024.3 5238.9 5242.1 5255.4 5264.4 5301.5 4757.6 4854.4 4975.5 4982.3 4983.9 5033.1 5036.0 5038.9 5090.6 5096.9 5103.9 5111.3 5111.9 5116.2 5165.4 4738.0 4826.9 4922.1 4922.2 4927.8 5045.4 5076.4 5085.0 5106.9 5129.1 5006.8 5008.3 5026.9 5054.3 5061.8 4885.6 5018.8 5092.0 5102.8 5111.7 4938.2 4938.4 4970.2 5010.4 5029.7 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#1] ext.html Cycles:180 Average:47635.75 Median:32734.35 stddev:85844.80 (262.2%) stddev-sans-first:86012.82 04:10:21 INFO - PROCESS | 16796 | Values: 548.6 579.1 590.6 592.4 596.4 26787.5 37564.6 38849.6 38853.4 38868.8 40432.8 40865.0 40952.2 40958.8 40978.4 7515.7 7717.3 7860.8 7871.6 9868.8 9710.6 10113.9 10120.3 10127.6 10131.9 10159.8 10177.1 10214.8 10225.6 10242.4 10097.3 10099.3 10169.9 10174.8 10176.5 9965.3 10016.3 10023.6 10033.5 10038.0 37950.0 38404.4 38421.0 38426.8 38440.8 3076.4 3102.3 3151.7 3343.4 3465.4 28986.3 29036.3 29612.1 29685.4 29782.0 2852.8 2930.3 2957.7 3020.9 3027.5 250827.0 251666.0 251946.0 251957.0 253126.0 51514.5 51654.2 51766.7 51983.5 52044.7 32197.2 54914.5 54916.5 55104.4 55106.4 14212.9 14932.8 14963.8 14990.3 15025.7 9364.3 11369.6 11684.0 11870.9 11993.8 17967.7 17977.7 18018.5 18024.2 18140.0 5390.6 6945.5 6952.5 7004.0 7224.3 766.3 809.8 880.5 898.5 934.6 27126.9 28196.6 28702.9 28922.7 28925.9 932.7 965.6 976.3 1033.6 1036.4 14304.4 14885.5 15046.6 15288.8 15302.4 401690.0 403697.0 404597.0 406221.0 406968.0 48853.0 49201.0 49501.8 49518.8 49628.8 1063.8 1143.3 1154.3 1182.5 1204.8 27602.6 28727.7 29314.3 29438.6 29645.3 41611.2 42140.0 42140.0 42165.4 42224.8 303349.0 303402.0 303810.0 304045.0 304202.0 24001.3 25195.4 25248.9 26432.5 26671.3 40803.8 40950.6 41560.8 41780.0 45841.0 35207.5 35679.5 36239.0 39182.8 40072.2 35961.3 36162.0 36582.3 36775.3 37227.4 35080.1 35246.6 35299.8 35747.0 36546.8 30941.7 32733.2 32735.5 32908.3 33034.3 24618.6 25177.4 25239.0 25357.6 25493.1 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#2] jquery.html Cycles:180 Average:24224.16 Median:4450.93 stddev:64853.27 (1457.1%) stddev-sans-first:65010.43 04:10:21 INFO - PROCESS | 16796 | Values: 356.2 373.1 380.1 382.6 391.1 12341.9 12792.2 17200.7 17218.4 17254.7 16267.3 16698.4 16934.1 16970.9 17072.7 3733.9 4847.8 5038.6 5041.4 5043.6 5609.4 5830.9 5916.9 6021.0 6028.3 5071.6 5377.4 5913.7 5981.3 5992.3 5391.5 5419.4 5424.2 5430.2 5430.8 4757.9 4997.1 5030.4 5247.2 5261.7 12427.4 12631.6 12702.5 12709.4 19049.8 1800.0 1812.2 1839.1 1997.1 2241.5 8420.5 8576.5 8866.4 9083.0 9091.9 1599.3 1658.4 1688.6 1745.3 1781.8 63891.7 67998.7 69025.0 69522.3 70898.6 9987.0 10158.1 10274.8 10408.5 10421.9 14253.6 14269.7 14270.6 14284.8 14290.4 7356.5 7491.7 7508.9 7573.9 7709.6 7126.7 7153.2 7309.8 7359.4 7370.9 4280.0 4382.6 4410.9 4491.0 4524.3 1554.5 1659.6 1785.8 1907.8 1914.5 786.4 807.0 810.6 849.3 851.6 16155.4 16275.2 17047.9 17572.6 17689.4 799.3 832.3 847.7 877.2 878.7 9010.7 9765.3 9802.6 9824.6 9843.0 377196.0 381183.0 400091.0 401728.0 402163.0 53081.5 79500.6 80120.6 81180.6 85007.6 842.8 915.7 956.5 973.8 978.2 13872.5 14563.4 14820.9 15834.8 15915.8 35322.5 37203.3 37312.1 39257.0 39620.8 52574.0 52710.5 53131.7 54949.7 54991.0 7293.5 7351.4 7394.0 7441.0 7641.8 8653.4 11019.9 11538.7 11544.0 12571.7 10455.9 10575.8 10580.8 10676.8 10736.1 10726.8 10784.5 10814.0 10852.2 11165.3 10398.5 10690.6 10833.5 10949.1 11189.9 7541.7 7575.6 7830.8 7995.2 8063.8 9625.3 10160.6 10264.2 10388.9 10674.2 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#3] mootools.html Cycles:180 Average:5276.12 Median:4886.91 stddev:2978.35 (60.9%) stddev-sans-first:2972.00 04:10:21 INFO - PROCESS | 16796 | Values: 1337.6 1370.7 1489.2 1689.1 1700.3 7696.2 8240.9 8250.1 8251.0 8259.8 6959.7 7680.8 7912.3 7917.4 8084.2 2231.5 2233.8 2248.3 2254.1 2262.3 2204.5 2215.0 2257.3 2278.5 2283.0 2263.3 2268.8 2275.5 2278.1 2291.3 2142.4 2153.4 2157.1 2159.7 2171.9 2159.5 2160.4 2165.7 2166.6 2168.6 8100.0 8101.9 8158.8 8177.3 8179.7 4713.7 4838.9 4842.8 4853.9 4855.3 2893.7 3041.8 3043.9 3049.8 3051.4 867.6 911.4 920.3 921.2 937.3 10957.4 10983.1 10993.1 10996.9 11005.3 4144.2 4391.9 4467.0 4472.8 4494.1 9506.5 9512.0 9516.4 9519.3 9523.8 4841.1 4850.8 4880.5 4883.5 4890.3 3824.1 4197.6 4384.1 4430.5 4441.7 3768.3 3789.9 3912.3 3932.1 3946.9 1208.1 1247.4 1251.6 1257.9 1263.4 805.9 826.0 828.6 837.4 840.4 5321.4 5332.2 5343.4 5408.5 5469.7 869.8 874.0 880.5 897.8 905.5 3572.3 3572.5 3642.7 3646.0 3662.2 9289.8 9763.3 10047.4 10194.1 10216.0 9890.2 10031.4 10104.4 10169.7 10186.0 7519.0 7660.6 7663.0 7663.5 7668.3 5197.3 5201.8 5230.2 5237.8 5261.0 9079.5 9102.9 9108.8 9134.3 9183.9 9090.0 9366.9 9418.5 9469.2 9472.7 5966.2 6590.2 6756.6 6764.2 7189.5 7500.2 7633.2 7797.8 7801.6 7811.5 6720.2 6867.2 6912.3 6978.7 7105.2 6651.5 6697.5 6735.5 6806.1 6964.6 6283.7 6341.2 6385.4 6393.2 6402.6 4269.4 4275.9 4521.7 4525.2 4567.9 4426.8 4514.8 4534.4 4643.6 4772.3 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#4] prototype.html Cycles:180 Average:4252.87 Median:4848.59 stddev:1222.36 (25.2%) stddev-sans-first:1189.29 04:10:21 INFO - PROCESS | 16796 | Values: 303.2 308.4 313.1 313.4 317.6 4872.8 4883.6 4892.6 4899.0 4902.6 4803.8 4808.5 4815.7 4818.3 4834.6 3620.4 3767.2 3790.4 3844.8 3845.7 3808.8 3846.2 3877.9 3887.3 3892.0 3806.7 3812.0 3816.6 3824.1 3833.9 3555.8 3669.3 3744.4 3797.8 3834.9 3304.9 3341.7 3342.5 3352.2 3361.4 4732.6 4769.3 4770.6 4790.2 4815.8 4172.0 4351.7 4367.4 4369.4 4375.7 5031.9 5042.2 5043.2 5050.0 5056.8 3663.2 3680.0 3690.8 3695.2 3697.3 5023.9 5290.7 5314.6 5360.8 5374.7 3768.5 3798.4 3848.5 3851.4 3857.4 3913.2 3926.8 3930.7 3936.7 3953.9 4417.3 4422.7 4445.4 4451.9 4466.0 4962.1 5092.5 5117.3 5130.5 5142.9 1333.9 1341.5 1343.2 1352.7 1356.5 857.0 882.5 898.5 900.2 902.8 4159.8 4396.6 4476.6 4567.3 4571.2 5178.9 5208.0 5221.3 5249.0 5255.7 4542.9 4558.9 4562.1 4574.3 4598.3 2653.5 2774.7 2777.3 2782.7 2784.7 4982.4 4991.9 5002.1 5004.8 5020.1 5198.0 5361.9 5370.7 5390.5 5392.7 4938.3 4953.3 4968.4 4975.7 5000.8 5252.5 5252.7 5253.7 5266.8 5286.2 4926.5 5152.8 5156.7 5227.0 5235.7 5016.4 5048.6 5053.8 5062.4 5070.1 3745.9 3755.3 3764.7 3792.9 3802.6 5060.8 5349.4 5360.6 5361.3 5374.6 5035.6 5045.6 5047.2 5052.4 5066.2 5103.5 5109.8 5115.8 5121.2 5141.5 4862.6 4978.0 5046.5 5066.3 5088.3 4891.5 5013.3 5095.4 5097.9 5123.2 4814.6 4915.6 4923.2 4934.7 4951.9 04:10:21 INFO - PROCESS | 16796 | 04:10:21 INFO - PROCESS | 16796 | [#5] yui.html Cycles:180 Average:16584.50 Median:29695.72 stddev:23413.75 (78.8%) stddev-sans-first:23448.62 04:10:21 INFO - PROCESS | 16796 | Values: 588.7 621.6 650.7 671.5 686.3 11426.3 11984.0 12000.3 12391.6 12417.8 12202.2 12260.4 12298.4 12570.3 13271.7 742.7 777.3 782.3 782.4 782.7 771.4 773.9 774.0 774.4 774.7 813.9 815.9 816.0 816.2 816.3 808.5 808.8 809.6 809.7 810.0 594.3 594.8 594.8 594.8 594.9 12639.9 12651.7 12680.5 12682.5 12692.9 11795.9 11909.4 12183.9 12319.5 13045.2 9929.1 9970.3 9976.0 10286.1 10436.8 3117.1 3156.1 3168.7 3182.1 3274.4 60313.7 60814.0 61279.4 61750.7 62060.7 8975.6 9057.5 9193.0 9200.2 9215.7 16089.8 16356.3 16367.3 16534.9 16537.3 6717.6 6732.9 6873.9 6908.1 6932.4 3540.5 3587.2 3618.1 3652.0 3662.1 2775.4 2870.7 2872.6 2874.5 2896.8 496.9 506.4 508.6 509.4 514.2 544.2 587.4 591.4 597.1 597.7 7663.3 7757.1 7798.6 7822.6 7916.0 551.0 561.6 573.2 576.0 585.1 3352.0 3523.4 3600.2 3637.1 3706.3 90259.5 91277.3 91977.0 93123.5 93542.0 55766.0 71134.0 71264.6 78621.6 82887.2 60673.0 62325.4 64158.4 72445.6 72545.6 7883.3 8339.7 8355.9 8399.0 8524.1 32232.0 40757.6 44251.6 44758.0 47486.0 58800.0 60471.7 60812.0 60921.4 63501.0 10224.5 10228.2 10250.7 10702.1 10970.3 11469.5 11898.9 12052.3 12534.8 12941.9 9955.6 10191.9 10267.6 10849.6 11258.3 11309.4 11700.6 11740.8 11831.5 12460.6 11235.3 11622.2 11954.1 12038.0 12042.6 8985.3 9132.9 9330.1 9604.2 9877.5 8683.0 9181.5 9214.7 9299.9 9363.1 04:10:21 INFO - PROCESS | 16796 | -------- Summary: end -------- 04:10:21 INFO - PROCESS | 16796 | 04:10:22 INFO - TEST-INFO | 16796: exit 0 04:10:22 INFO - TEST-OK | dromaeo_css | took 1120359ms 04:10:22 INFO - TEST-START | kraken 04:10:22 INFO - operating with platform_type : linux_ 04:10:22 INFO - Initialising browser for kraken test... 04:10:22 INFO - TEST-INFO | started process 16981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXE75L_/profile http://localhost:45608/getInfo.html) 04:10:26 INFO - PROCESS | 16981 | __metrics Screen width/height:1600/1200 04:10:26 INFO - PROCESS | 16981 | colorDepth:24 04:10:26 INFO - PROCESS | 16981 | Browser inner width/height: 1024/697 04:10:26 INFO - PROCESS | 16981 | __metrics 04:10:27 INFO - PROCESS | 16981 | 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" 04:10:27 INFO - PROCESS | 16981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:28 INFO - TEST-INFO | 16981: exit 0 04:10:28 INFO - Browser initialized. 04:10:28 INFO - Running cycle 1/1 for kraken test... 04:10:28 INFO - TEST-INFO | started process 17060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXE75L_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:40 INFO - PROCESS | 17060 | RSS: Main: 157175808 04:10:40 INFO - PROCESS | 17060 | 04:10:42 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45608/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:43 INFO - PROCESS | 17060 | RSS: Main: 213270528 04:10:43 INFO - PROCESS | 17060 | 04:10:46 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45608/tests/kraken/driver.html?testName=audio-dft) 04:10:46 INFO - PROCESS | 17060 | RSS: Main: 187928576 04:10:46 INFO - PROCESS | 17060 | 04:10:50 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45608/tests/kraken/driver.html?testName=audio-fft) 04:10:50 INFO - PROCESS | 17060 | RSS: Main: 271839232 04:10:50 INFO - PROCESS | 17060 | 04:10:53 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45608/tests/kraken/driver.html?testName=audio-oscillator) 04:10:53 INFO - PROCESS | 17060 | RSS: Main: 180817920 04:10:53 INFO - PROCESS | 17060 | 04:10:55 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45608/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:56 INFO - PROCESS | 17060 | RSS: Main: 185274368 04:10:56 INFO - PROCESS | 17060 | 04:10:59 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45608/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:00 INFO - PROCESS | 17060 | RSS: Main: 221077504 04:11:00 INFO - PROCESS | 17060 | 04:11:03 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45608/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:04 INFO - PROCESS | 17060 | RSS: Main: 215736320 04:11:04 INFO - PROCESS | 17060 | 04:11:07 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45608/tests/kraken/driver.html?testName=json-parse-financial) 04:11:07 INFO - PROCESS | 17060 | RSS: Main: 218324992 04:11:07 INFO - PROCESS | 17060 | 04:11:09 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45608/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:10 INFO - PROCESS | 17060 | RSS: Main: 184012800 04:11:10 INFO - PROCESS | 17060 | 04:11:12 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:12 INFO - PROCESS | 17060 | RSS: Main: 189616128 04:11:12 INFO - PROCESS | 17060 | 04:11:14 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:15 INFO - PROCESS | 17060 | RSS: Main: 193728512 04:11:15 INFO - PROCESS | 17060 | 04:11:18 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:18 INFO - PROCESS | 17060 | RSS: Main: 188870656 04:11:18 INFO - PROCESS | 17060 | 04:11:21 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:22 INFO - PROCESS | 17060 | RSS: Main: 192487424 04:11:22 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | Cycle 1(1): loaded http://localhost:45608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45608/tests/kraken/driver.html?testName=ai-astar) 04:11:24 INFO - PROCESS | 17060 | RSS: Main: 243216384 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | __start_tp_report 04:11:24 INFO - PROCESS | 17060 | _x_x_mozilla_page_load 04:11:24 INFO - PROCESS | 17060 | _x_x_mozilla_page_load_details 04:11:24 INFO - PROCESS | 17060 | |i|pagename|runs| 04:11:24 INFO - PROCESS | 17060 | |0;ai-astar;103;114;114;113;113;114;112;113;114;113 04:11:24 INFO - PROCESS | 17060 | |1;audio-beat-detection;145;122;122;181;129;128;152;123;160;121 04:11:24 INFO - PROCESS | 17060 | |2;audio-dft;163;163;162;161;160;161;162;162;170;161 04:11:24 INFO - PROCESS | 17060 | |3;audio-fft;75;76;77;120;76;76;75;75;103;75 04:11:24 INFO - PROCESS | 17060 | |4;audio-oscillator;85;85;119;85;86;86;140;85;85;129 04:11:24 INFO - PROCESS | 17060 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 04:11:24 INFO - PROCESS | 17060 | |6;imaging-darkroom;146;146;146;145;148;147;145;146;147;145 04:11:24 INFO - PROCESS | 17060 | |7;imaging-desaturate;95;94;95;95;95;94;94;94;95;94 04:11:24 INFO - PROCESS | 17060 | |8;json-parse-financial;62;61;61;61;62;62;61;63;61;61 04:11:24 INFO - PROCESS | 17060 | |9;json-stringify-tinderbox;68;65;66;65;66;65;66;66;65;65 04:11:24 INFO - PROCESS | 17060 | |10;stanford-crypto-aes;78;83;78;83;78;78;78;85;78;83 04:11:24 INFO - PROCESS | 17060 | |11;stanford-crypto-ccm;133;133;134;133;130;129;128;126;170;136 04:11:24 INFO - PROCESS | 17060 | |12;stanford-crypto-pbkdf2;168;170;166;171;164;165;164;164;163;164 04:11:24 INFO - PROCESS | 17060 | |13;stanford-crypto-sha256-iterative;68;68;67;68;73;68;66;69;65;68 04:11:24 INFO - PROCESS | 17060 | __end_tp_report 04:11:24 INFO - PROCESS | 17060 | __start_cc_report 04:11:24 INFO - PROCESS | 17060 | _x_x_mozilla_cycle_collect,1935 04:11:24 INFO - PROCESS | 17060 | __end_cc_report 04:11:24 INFO - PROCESS | 17060 | __startTimestamp1469877084435__endTimestamp 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | ------- Summary: start ------- 04:11:24 INFO - PROCESS | 17060 | Number of tests: 14 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.33 (2.9%) stddev-sans-first:0.71 04:11:24 INFO - PROCESS | 17060 | Values: 103.0 114.0 114.0 113.0 113.0 114.0 112.0 113.0 114.0 113.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:137.00 stddev:20.51 (15.0%) stddev-sans-first:21.61 04:11:24 INFO - PROCESS | 17060 | Values: 145.0 122.0 122.0 181.0 129.0 128.0 152.0 123.0 160.0 121.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.96 04:11:24 INFO - PROCESS | 17060 | Values: 163.0 163.0 162.0 161.0 160.0 161.0 162.0 162.0 170.0 161.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:15.66 (20.7%) stddev-sans-first:16.36 04:11:24 INFO - PROCESS | 17060 | Values: 75.0 76.0 77.0 120.0 76.0 76.0 75.0 75.0 103.0 75.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:85.00 stddev:21.85 (25.7%) stddev-sans-first:22.62 04:11:24 INFO - PROCESS | 17060 | Values: 85.0 85.0 119.0 85.0 86.0 86.0 140.0 85.0 85.0 129.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:11:24 INFO - PROCESS | 17060 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 04:11:24 INFO - PROCESS | 17060 | Values: 146.0 146.0 146.0 145.0 148.0 147.0 145.0 146.0 147.0 145.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:11:24 INFO - PROCESS | 17060 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:11:24 INFO - PROCESS | 17060 | Values: 62.0 61.0 61.0 61.0 62.0 62.0 61.0 63.0 61.0 61.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.53 04:11:24 INFO - PROCESS | 17060 | Values: 68.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:2.90 (3.6%) stddev-sans-first:2.96 04:11:24 INFO - PROCESS | 17060 | Values: 78.0 83.0 78.0 83.0 78.0 78.0 78.0 85.0 78.0 83.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:133.00 stddev:12.60 (9.5%) stddev-sans-first:13.34 04:11:24 INFO - PROCESS | 17060 | Values: 133.0 133.0 134.0 133.0 130.0 129.0 128.0 126.0 170.0 136.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:2.81 (1.7%) stddev-sans-first:2.87 04:11:24 INFO - PROCESS | 17060 | Values: 168.0 170.0 166.0 171.0 164.0 165.0 164.0 164.0 163.0 164.0 04:11:24 INFO - PROCESS | 17060 | 04:11:24 INFO - PROCESS | 17060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.24 04:11:24 INFO - PROCESS | 17060 | Values: 68.0 68.0 67.0 68.0 73.0 68.0 66.0 69.0 65.0 68.0 04:11:24 INFO - PROCESS | 17060 | -------- Summary: end -------- 04:11:24 INFO - PROCESS | 17060 | 04:11:25 INFO - TEST-INFO | 17060: exit 0 04:11:25 INFO - TEST-OK | kraken | took 63359ms 04:11:25 INFO - SUITE-END | took 1183s 04:11:25 INFO - Completed test suite (00:19:43) 04:11:25 INFO - javascript benchmark 04:11:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.4277930244994, 2668.546347120992, 2687.9999999999995, 2714.674239091308, 2720.918372448826, 4640.628749700024, 4763.690360126589, 4799.7360145192, 4830.516948305168, 4848.975755121228, 4755.476897541268, 4760.381150450446, 4794.089123066615, 4823.614110871131, 4874.268859671051, 4422.469303683562, 4447.57748013939, 4468.932966005513, 4481.148581769454, 4602.286645569942, 4565.0, 4566.246569316058, 4570.588647021767, 4571.3143028545655, 4587.0596527711905, 4353.5428779977965, 4391.692581519295, 4418.072204836988, 4472.217361961643, 4476.104779044204, 4465.9106817863785, 4475.373447717322, 4475.77621118946, 4477.1493416250805, 4479.529649386833, 4356.106998065389, 4403.097365040191, 4428.357888106207, 4435.62297204738, 4503.887402814923, 4743.667943243974, 4807.831725889577, 4810.518948105197, 4888.682235654706, 4911.803527858881, 5200.29795977542, 5235.345581802275, 5252.369715634149, 5253.08071087562, 5254.737263136828, 4967.7764500597195, 5035.823746168903, 5049.873753156164, 5155.922661160085, 5254.579633629301, 4827.058723548945, 4895.265710143507, 4912.091263116335, 4915.361003069578, 4920.6309526785635, 5349.1976203569775, 5355.30381050461, 5426.538744206787, 5431.402545719968, 5432.483914028161, 4905.558499735041, 5064.594832413398, 5070.721110338893, 5182.24857395683, 5188.558972487305, 5236.136037553837, 5279.234510995884, 5282.894342113136, 5285.2600635911, 5289.894202116013, 5083.389993200765, 5128.282040514331, 5135.7432128394175, 5194.610404219623, 5242.108841496878, 4867.172580661296, 4997.175466048134, 5073.568746656501, 5104.1067813133295, 5158.97420512895, 4425.849279187434, 4426.75652839097, 4451.688381813242, 4464.374987501752, 4464.866054018385, 3871.2257548490416, 3894.357431023906, 3895.7662540247675, 3919.5884432134217, 3947.5657677655436, 4368.060866913629, 4429.15845989261, 4462.888427789331, 4548.226801443762, 4555.977220113945, 5143.099957507421, 5168.560672342893, 5195.558377537952, 5235.816746413857, 5243.397009343974, 4494.865154045384, 4525.162844873709, 4533.433320834895, 4538.160440318552, 4585.770711464414, 4565.497795242521, 4676.251799712029, 4710.601091808429, 4733.881652958704, 4768.141734487756, 4920.778564964514, 4976.377952755905, 4981.6014718823135, 5022.422421421583, 5024.321716568216, 5238.947610523846, 5242.056429842665, 5255.421903590525, 5264.368275806928, 5301.549368303583, 4757.5718185363485, 4854.417469903634, 4975.50244975514, 4982.302477653204, 4983.875403114951, 5033.094043072282, 5035.974820125876, 5038.874028149326, 5090.592752579711, 5096.949030509648, 5103.923441148311, 5111.309973153577, 5111.872203194801, 5116.181410974226, 5165.431802501646, 4737.952620473751, 4826.927596085991, 4922.064807686528, 4922.163232250455, 4927.778249978688, 5045.4450010498085, 5076.416212135652, 5085.0, 5106.948930510647, 5129.128048231884, 5006.774695138801, 5008.273800299009, 5026.899462010812, 5054.317667114892, 5061.772220250171, 4885.5847252983895, 5018.799248030038, 5091.974540127276, 5102.770375333193, 5111.667741596784, 4938.209886418156, 4938.43208031081, 4970.204767237225, 5010.448850626501, 5029.698218106925], "value": 4763.842802836603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5976934803057, 579.1110645159681, 590.5659340384819, 592.4371846745587, 596.4244504053587, 26787.464250714973, 37564.62435375645, 38849.61150388495, 38853.417198742005, 38868.80565597168, 40432.797836010854, 40865.0, 40952.18095638086, 40958.795206023926, 40978.38532422016, 7515.736949206779, 7717.305442510173, 7860.764177074697, 7871.567063811488, 9868.753281167992, 9710.563024663907, 10113.89886101137, 10120.291579589431, 10127.645532406368, 10131.949340253324, 10159.796804063913, 10177.134943529809, 10214.795704085915, 10225.590976360936, 10242.385456872611, 10097.293189476739, 10099.29304948654, 10169.898301017007, 10174.796504069951, 10176.542055607515, 9965.252606054502, 10016.298859079867, 10023.59905603775, 10033.49832508379, 10038.046385593358, 37950.0, 38404.42393364102, 38421.0, 38426.80786596077, 38440.80779596084, 3076.3539656672124, 3102.3329984053535, 3151.6848315168527, 3343.36476069546, 3465.4108801503803, 28986.27534311638, 29036.27409314763, 29612.111636650934, 29685.406291874257, 29782.02179782026, 2852.82883027017, 2930.340673348501, 2957.6746557878614, 3020.9244768880735, 3027.455058089543, 250827.0, 251666.0, 251946.0, 251957.0, 253126.0, 51514.48485515172, 51654.22518662223, 51766.74116629393, 51983.48016519786, 52044.73977630088, 32197.195070123435, 54914.450855491734, 54916.45083549193, 55104.448955509935, 55106.44893551013, 14212.928935355258, 14932.776008359884, 14963.775543366859, 14990.250487475583, 15025.699486010219, 9364.25085993119, 11369.602063927723, 11684.0, 11870.881291186977, 11993.760124797454, 17967.73048404275, 17977.730334044998, 18018.459446216635, 18024.188911499015, 18140.002299873635, 5390.568754499631, 6945.548539344926, 6952.478564107712, 7003.968849033825, 7224.277572242839, 766.2567309709573, 809.7773112394138, 880.5377176982136, 898.4833720610544, 934.56075644447, 27126.86436567844, 28196.577051344248, 28702.85648571744, 28922.710772892424, 28925.85537072343, 932.7061975477703, 965.6137544982064, 976.3165783951263, 1033.5968972100886, 1036.429963520061, 14304.356303966139, 14885.479008234659, 15046.623834404008, 15288.770668439982, 15302.387904483918, 401690.0, 403697.0, 404597.0, 406221.0, 406968.0, 48853.02293954172, 49201.0, 49501.75249123803, 49518.75240623846, 49628.75185624049, 1063.7500187455942, 1143.2968724234536, 1154.318951818431, 1182.4501606752558, 1204.7710934922336, 27602.585961210196, 28727.71272287334, 29314.267143321587, 29438.558421623264, 29645.25886852846, 41611.16777664369, 42140.0, 42140.0, 42165.367519486615, 42224.78887605542, 303349.0, 303402.0, 303810.0, 304045.0, 304202.0, 24001.27996160118, 25195.370115747253, 25248.873755631103, 26432.471350573265, 26671.33321666974, 40803.7959810199, 40950.59049409468, 41560.79219603883, 41780.0, 45841.0, 35207.47188792119, 35679.464808027384, 36239.0, 39182.84494352838, 40072.198556029296, 35961.28077438489, 36162.0, 36582.26835463329, 36775.26449471049, 37227.441588376736, 35080.12299692528, 35246.64753352434, 35299.82350088336, 35747.0, 36546.8172659135, 30941.69058309478, 32733.18167045843, 32735.508967365033, 32908.34183316368, 33034.33931321312, 24618.630720539564, 25177.370565736004, 25239.0, 25357.61963570511, 25493.107741228967], "value": 17938.075158977448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.1647935591038, 373.121299340054, 380.1124374585344, 382.5772521363893, 391.0829105747022, 12341.899069735595, 12792.232466052032, 17200.655986880287, 17218.39735609254, 17254.741178882326, 16267.267972941216, 16698.415555455562, 16934.06862622555, 16970.915145424286, 17072.658546829058, 3733.850645974158, 4847.757612119389, 5038.571721403685, 5041.369828771403, 5043.621728370368, 5609.439056094398, 5830.912536311958, 5916.940830591703, 6020.969895150518, 6028.336882942873, 5071.594272458213, 5377.4084850666595, 5913.674747888865, 5981.342052374235, 5992.280926288851, 5391.514763671269, 5419.403865574784, 5424.240606315119, 5430.185472179165, 5430.782768689248, 4757.881052973668, 4997.05056039355, 5030.446650868402, 5247.1866860636665, 5261.7369131543655, 12427.3786310685, 12631.621051368473, 12702.491900323976, 12709.364531773466, 19049.80950190508, 1800.0369802155915, 1812.2298023340027, 1839.1356062650532, 1997.0913234478278, 2241.4620491082187, 8420.494770313739, 8576.485410875368, 8866.42368246062, 9083.0, 9091.863622045674, 1599.3043026283603, 1658.4361317152227, 1688.6031782531095, 1745.2844333823073, 1781.7594624725755, 63891.68054159746, 67998.66000669965, 69025.0, 69522.30477695209, 70898.64550677265, 9986.950065249628, 10158.104940092038, 10274.845877311845, 10408.531616077144, 10421.9478902605, 14253.643658908402, 14269.714605708035, 14270.643233919027, 14284.785728214085, 14290.42838286457, 7356.485046046832, 7491.737789177461, 7508.924910750932, 7573.886391704129, 7709.575973321409, 7126.714931402686, 7153.248908864598, 7309.817254568572, 7359.448041396917, 7370.926290737024, 4280.0, 4382.561743825592, 4410.867673969786, 4491.0, 4524.343970124313, 1554.4947891935167, 1659.6348803263263, 1785.7946336171506, 1907.809219078081, 1914.5022294203607, 786.4101923557332, 806.9959650201829, 810.6473683947502, 849.3375167369462, 851.5912362066243, 16155.353785848434, 16275.186240687919, 17047.91476042612, 17572.560685982953, 17689.380871669688, 799.2926260259596, 832.3299743706253, 847.7329641163014, 877.1886005444937, 878.7056336127469, 9010.684626038057, 9765.316427850124, 9802.5588848502, 9824.607015719434, 9842.950785246028, 377196.0, 381183.0, 400091.0, 401728.0, 402163.0, 53081.46918530765, 79500.60249698715, 80120.59939700265, 81180.59409702914, 85007.5749621248, 842.8272204198247, 915.6657819895823, 956.4691596164196, 973.776031512756, 978.1734434402919, 13872.514461993782, 14563.41746330135, 14820.851791481948, 15834.841651583336, 15915.840841591436, 35322.47016294809, 37203.255934881694, 37312.07879730478, 39257.0, 39620.801895990335, 52574.0, 52710.519605833935, 53131.73434132805, 54949.725251373486, 54991.0, 7293.452991025801, 7351.3751331137455, 7394.0, 7440.962795185989, 7641.7707468776025, 8653.437526560754, 11019.889801102207, 11538.653840384803, 11544.017314026647, 12571.685707857378, 10455.94772026135, 10575.841362379724, 10580.788384232426, 10676.83984740214, 10736.141108711441, 10726.839097413702, 10784.460776960963, 10813.999410109154, 10852.186086043735, 11165.330080195214, 10398.532066056894, 10690.572377104829, 10833.512491937725, 10949.124070074535, 11189.944050280023, 7541.7360392386, 7575.583342916192, 7830.76507704747, 7995.240452157036, 8063.83872322562, 9625.32622716403, 10160.593576256866, 10264.178865690876, 10388.896111039096, 10674.199435042248], "value": 8125.373316332373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.5920344294989, 1370.6504841265476, 1489.2107183192904, 1689.0625702734976, 1700.2773821126011, 7696.153423123459, 8240.917590824098, 8250.133735957728, 8251.0, 8259.834803303931, 6959.652017399122, 7680.807979800507, 7912.287894089531, 7917.406194535419, 8084.191580841913, 2231.520223152026, 2233.7877901599322, 2248.3367406615007, 2254.0532976150057, 2262.332611879491, 2204.548067646129, 2214.966775498369, 2257.255105815077, 2278.5329007553496, 2283.0068920019844, 2263.298377502971, 2268.7958083772455, 2275.5221403505284, 2278.1456953642382, 2291.2897001929373, 2142.368001439579, 2153.386284908809, 2157.083239623154, 2159.654455287154, 2171.9457013574706, 2159.492519257973, 2160.362693005567, 2165.7184566006476, 2166.566686662658, 2168.5988092202992, 8099.95950020252, 8101.878471822927, 8158.755237342889, 8177.304929081035, 8179.672813087469, 4713.6936099153445, 4838.903221935541, 4842.757862106881, 4853.854384368475, 4855.295982082578, 2893.652761668613, 3041.8022828516296, 3043.9391212175856, 3049.786514943955, 3051.359214564944, 867.6182479708971, 911.3893691226893, 920.2775820980498, 921.1939552891221, 937.3485427627801, 10957.397343146124, 10983.066439352664, 10993.065589424908, 10996.890031099747, 11005.339679619248, 4144.191882582867, 4391.945932976127, 4467.039586488921, 4472.763618190905, 4494.1461122386645, 9506.524673766284, 9512.04879512057, 9516.429014259167, 9519.333646644669, 9523.761905952268, 4841.12859685253, 4850.781714822841, 4880.487548807395, 4883.487233840467, 4890.339804126468, 3824.0631045394057, 4197.601227883346, 4384.079343337871, 4430.534793846599, 4441.71128876622, 3768.2651882883124, 3789.8673546426294, 3912.256671232514, 3932.0956180078742, 3946.940795888064, 1208.0818577880698, 1247.357610830423, 1251.599488163797, 1257.8993680505537, 1263.3935710858839, 805.8549461096942, 826.0376661189766, 828.5608627427473, 837.351052933981, 840.3907167303778, 5321.388040375329, 5332.226827110047, 5343.3587969443915, 5408.45915408456, 5469.671819690831, 869.8477766390982, 873.9949058582554, 880.5113162195044, 897.7845317123974, 905.5291248550849, 3572.339117263263, 3572.517710109154, 3642.7267954903486, 3646.033801042726, 3662.230931504361, 9289.814203716023, 9763.316567840184, 10047.447390393452, 10194.133498652549, 10215.978402159724, 9890.159336456481, 10031.398116113056, 10104.393736375841, 10169.745756356151, 10185.981401859755, 7518.962405187939, 7660.61696915152, 7662.999999999888, 7663.463557551029, 7668.271514206142, 5197.272381866617, 5201.791928322825, 5230.241614965733, 5237.790488380575, 5260.9736951315, 9079.500627465553, 9102.863457048283, 9108.772280693036, 9134.314926380415, 9183.862242066241, 9090.0, 9366.859497107685, 9418.481983490974, 9469.195118414736, 9472.715818525456, 5966.224390829165, 6590.209174899042, 6756.594604323756, 6764.188297404343, 7189.496735228484, 7500.174980752222, 7633.2366763323225, 7797.844043118992, 7801.609919503889, 7811.531308121531, 6720.193576770819, 6867.175938887166, 6912.27421120775, 6978.720851166099, 7105.18290396611, 6651.501137414616, 6697.464202863662, 6735.461163106842, 6806.115205023315, 6964.582125072512, 6283.654399007915, 6341.175647165839, 6385.393387628168, 6393.1688880445245, 6402.647854368054, 4269.4449721536, 4275.893102672458, 4521.683482156349, 4525.230710779109, 4567.931481027721, 4426.822927082881, 4514.796834142538, 4534.365188873494, 4643.582077613031, 4772.331873537777], "value": 4238.94742258555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.18594573569965, 308.426327031721, 313.06081754735794, 313.3904555639281, 317.6061683512444, 4872.75636218189, 4883.584895283901, 4892.608591312695, 4898.975505122469, 4902.632302577304, 4803.759812009394, 4808.519148085198, 4815.735134567597, 4818.349522814419, 4834.613230941516, 3620.3664358737183, 3767.2465506898593, 3790.4314352847155, 3844.826982785781, 3845.6923446124383, 3808.847646094153, 3846.2307538492273, 3877.8836634901, 3887.280853042196, 3891.9805400972955, 3806.7437745544044, 3811.9517132788565, 3816.618338166175, 3824.120452295974, 3833.9041523961846, 3555.8044307563073, 3669.302832461837, 3744.4383342498845, 3797.810109494542, 3834.8657796977113, 3304.9173770655925, 3341.665833416663, 3342.4819153031317, 3352.2122301259183, 3361.445361515347, 4732.550407711262, 4769.332293478881, 4770.642201834877, 4790.209615413452, 4815.783289751969, 4172.0, 4351.6518678505645, 4367.410399596078, 4369.410129632491, 4375.6937014409, 5031.861458879998, 5042.20157812414, 5043.167877300241, 5049.974750126225, 5056.772445239973, 3663.19409729859, 3679.981600092009, 3690.760100593453, 3695.1870588470492, 3697.2605478904325, 5023.924641130349, 5290.735463226823, 5314.574834013309, 5360.839174824722, 5374.677519348852, 3768.5289338832645, 3798.3732684106812, 3848.461215429842, 3851.383778595411, 3857.360621735751, 3913.178232571192, 3926.784026878549, 3930.705197110171, 3936.704747143918, 3953.940690889639, 4417.337399390117, 4422.673198040575, 4445.399226626443, 4451.863105709278, 4465.972826249981, 4962.057209130254, 5092.541671249605, 5117.334746483008, 5130.461301563282, 5142.897142057138, 1333.8732820382047, 1341.5438750824571, 1343.1806597975228, 1352.6550729563899, 1356.5184359552413, 857.0229937870832, 882.4572887674162, 898.4905358996948, 900.1628485508539, 902.8106840910896, 4159.812808423628, 4396.626286765597, 4476.6418686505, 4567.3377360282575, 4571.22289210835, 5178.922316165261, 5207.973960130251, 5221.295125158055, 5249.0, 5255.737213139328, 4542.863714088583, 4558.88602784933, 4562.110388474216, 4574.290984897346, 4598.3329668792685, 2653.509100816355, 2774.722527747209, 2777.291790593386, 2782.65216847894, 2784.693683694792, 4982.352294201731, 4991.925121123186, 5002.1496345621335, 5004.799808007711, 5020.146575082244, 5198.012377648235, 5361.919571206435, 5370.650907690988, 5390.460953904578, 5392.703401312965, 4938.333325001079, 4953.331300274489, 4968.354113965162, 4975.676581022294, 5000.824971126066, 5252.527272545489, 5252.684838909678, 5253.658512196695, 5266.762995665281, 5286.15421532553, 4926.5073492650445, 5152.793888244429, 5156.664816786897, 5226.973865130803, 5235.685858848481, 5016.448190699093, 5048.62714524173, 5053.772580233972, 5062.443131255633, 5070.138076526926, 3745.9063523412133, 3755.3240416725253, 3764.661180493769, 3792.8672496463596, 3802.6007269236334, 5060.797568097235, 5349.411564727799, 5360.579446446773, 5361.303030605996, 5374.57003439716, 5035.647504674637, 5045.596352291735, 5047.2429135629945, 5052.444231134646, 5066.240063990431, 5103.515166059218, 5109.821156259513, 5115.846524604268, 5121.231815227746, 5141.511556402136, 4862.562369386631, 4977.9502204978935, 5046.545810876892, 5066.341375621146, 5088.338515992898, 4891.5353041461, 5013.2981382607195, 5095.414027386898, 5097.9490205098955, 5123.180291153398, 4814.5907597853175, 4915.557599816034, 4923.236898280772, 4934.679245849008, 4951.851444456672], "value": 3868.4110180705284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6997631208084, 621.6363427394974, 650.7071817682045, 671.5232185148543, 686.3068301015976, 11426.257293275941, 11984.041276697864, 12000.339981301036, 12391.566295179671, 12417.813732793993, 12202.206856554318, 12260.448279827408, 12298.446569904354, 12570.30863302518, 13271.668208294797, 742.6620887496176, 777.3276116159537, 782.2881178127905, 782.4092809928525, 782.7299581644323, 771.4291424346, 773.8993930789018, 773.97678069658, 774.4462709162948, 774.6978678315461, 813.8860559521672, 815.8653822119343, 816.0207750699155, 816.1919699497485, 816.346922462031, 808.462372522272, 808.7614153824636, 809.6154326694802, 809.6963638635511, 810.0117856215437, 594.3046635436507, 594.7829042399493, 594.8156071617813, 594.8423667728056, 594.8691287916652, 12639.925606323473, 12651.683707907285, 12680.492780288778, 12682.492700291978, 12692.873071269261, 11795.94102029493, 11909.404529773563, 12183.878161218363, 12319.5072197112, 13045.152065115832, 9929.106380425725, 9970.252231082697, 9976.0, 10286.074253317163, 10436.791264174673, 3117.08046126391, 3156.1478400831875, 3168.683131686813, 3182.0931034655014, 3274.361499507597, 60313.69843150756, 60814.0, 61279.387206127816, 61750.69124654348, 62060.68969655168, 8975.640974360953, 9057.501837399006, 9193.0, 9200.171984521425, 9215.723528294027, 16089.758653620205, 16356.263968121462, 16367.345306187857, 16534.917325413535, 16537.338506459608, 6717.56335838169, 6732.899006514906, 6873.862522749517, 6908.067410899464, 6932.44540436774, 3540.5220295260324, 3587.2287458196615, 3618.095476130967, 3652.0, 3662.102784817737, 2775.417162395879, 2870.72728090831, 2872.6409198850142, 2874.453853767777, 2896.841263494619, 496.9304297398367, 506.39232920494817, 508.6464906889676, 509.41671785805045, 514.1901505129437, 544.2435015328696, 587.3597778421541, 591.4499515450672, 597.128192838452, 597.7250464786247, 7663.348615367645, 7757.146713861471, 7798.610069496503, 7822.569758663214, 7916.0, 550.9531689806331, 561.6433564686454, 573.2118337286231, 575.9625624334404, 585.1456872965433, 3352.0, 3523.436250199956, 3600.2439487707875, 3637.0907273181706, 3706.3328600852105, 90259.54870225738, 91277.33894335717, 91977.0, 93123.53438232765, 93542.0, 55766.0, 71134.0, 71264.64367678128, 78621.60689196517, 82887.17112828915, 60673.0, 62325.37674623286, 64158.35841641524, 72445.6377718108, 72545.6372718133, 7883.329916956894, 8339.708110216114, 8355.874661880198, 8398.958005209935, 8524.104968978416, 32232.0, 40757.59242407538, 44251.55748442603, 44758.0, 47485.96369308647, 58800.0, 60471.697641513274, 60812.0, 60921.39078609157, 63501.0, 10224.488775561043, 10228.232882533692, 10250.743731406774, 10702.09032232269, 10970.341779493256, 11469.541218351173, 11898.940505297418, 12052.276863388224, 12534.811977820522, 12941.935290323489, 9955.601775929172, 10191.94904025475, 10267.58929642806, 10849.620263290746, 11258.324500529994, 11309.377984210947, 11700.648980530597, 11740.82591740819, 11831.52673893069, 12460.626181214579, 11235.269707469315, 11622.244554103956, 11954.103442241692, 12038.03695704359, 12042.63872083839, 8985.312086980426, 9132.908670913206, 9330.066993300887, 9604.186592793414, 9877.456739879375, 8683.0, 9181.540922953693, 9214.723558293263, 9299.907000929905, 9363.110504502061], "value": 6275.374509437119, "unit": "score"}], "name": "dromaeo_css", "value": 6441.828882085808, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 122.0, 181.0, 129.0, 128.0, 152.0, 123.0, 160.0, 121.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0, 170.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 120.0, 76.0, 76.0, 75.0, 75.0, 103.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 85.0, 86.0, 86.0, 140.0, 85.0, 85.0, 129.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 148.0, 147.0, 145.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 63.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 78.0, 83.0, 78.0, 78.0, 78.0, 85.0, 78.0, 83.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 134.0, 133.0, 130.0, 129.0, 128.0, 126.0, 170.0, 136.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 166.0, 171.0, 164.0, 165.0, 164.0, 164.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 73.0, 68.0, 66.0, 69.0, 65.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1528.4000000000003, "alertThreshold": 2.0}]} 04:11:25 INFO - Return code: 0 04:11:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:25 INFO - # TBPL SUCCESS # 04:11:25 INFO - Running post-action listener: _resource_record_post_action 04:11:25 INFO - [mozharness: 2016-07-30 11:11:25.712805Z] Finished run-tests step (success) 04:11:25 INFO - Running post-run listener: _resource_record_post_run 04:11:25 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526405632; Read time: 12; Write time: 433352 04:11:25 INFO - TinderboxPrint: CPU usage
13.0% 04:11:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:11:25 INFO - TinderboxPrint: I/O write bytes / time
526,405,632 / 433,352 04:11:25 INFO - TinderboxPrint: CPU idle
8,333.1 (87.0%) 04:11:25 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 04:11:25 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240562176; Read time: 0; Write time: 234436 04:11:25 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285519872; Read time: 12; Write time: 198880 04:11:26 INFO - Running post-run listener: _upload_blobber_files 04:11:26 INFO - Blob upload gear active. 04:11:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11: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 04:11: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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:11: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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:11:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:11:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:27 INFO - (blobuploader) - INFO - Done attempting. 04:11:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:11:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:28 INFO - (blobuploader) - INFO - Done attempting. 04:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:31 INFO - (blobuploader) - INFO - Done attempting. 04:11:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:31 INFO - Return code: 0 04:11:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/451815133010da5b79f3f975d23583f38e0a022dcf72cf1eccda6910feb662eb945221ef2949f2bb0461b7649a26c240bb2e1a2ac7d29803a163964bd200b1b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ddfbc2fa6692d205292520756ca3e168b5c346f52b465d8555e7f03fd6e388099bfe75f50c5caa909be930335622136df02736a5471b01bc94188c66e488efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634678278acdac3c4f53a7247176e97c3600d7019ad8d1addff14c1315fdc67d6834219823255d3a92977ad5468f81a4e465ee50ababcbf46fd4f70131040beb"} 04:11:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:31 INFO - Contents: 04:11:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/451815133010da5b79f3f975d23583f38e0a022dcf72cf1eccda6910feb662eb945221ef2949f2bb0461b7649a26c240bb2e1a2ac7d29803a163964bd200b1b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ddfbc2fa6692d205292520756ca3e168b5c346f52b465d8555e7f03fd6e388099bfe75f50c5caa909be930335622136df02736a5471b01bc94188c66e488efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634678278acdac3c4f53a7247176e97c3600d7019ad8d1addff14c1315fdc67d6834219823255d3a92977ad5468f81a4e465ee50ababcbf46fd4f70131040beb"} 04:11:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:31 INFO - Copying logs to upload dir... 04:11:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.554415 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-30 04:11:31.646983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:31.650365) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/451815133010da5b79f3f975d23583f38e0a022dcf72cf1eccda6910feb662eb945221ef2949f2bb0461b7649a26c240bb2e1a2ac7d29803a163964bd200b1b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ddfbc2fa6692d205292520756ca3e168b5c346f52b465d8555e7f03fd6e388099bfe75f50c5caa909be930335622136df02736a5471b01bc94188c66e488efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634678278acdac3c4f53a7247176e97c3600d7019ad8d1addff14c1315fdc67d6834219823255d3a92977ad5468f81a4e465ee50ababcbf46fd4f70131040beb"} build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/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/Fx-Team-Non-PGO/sha512/451815133010da5b79f3f975d23583f38e0a022dcf72cf1eccda6910feb662eb945221ef2949f2bb0461b7649a26c240bb2e1a2ac7d29803a163964bd200b1b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ddfbc2fa6692d205292520756ca3e168b5c346f52b465d8555e7f03fd6e388099bfe75f50c5caa909be930335622136df02736a5471b01bc94188c66e488efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/634678278acdac3c4f53a7247176e97c3600d7019ad8d1addff14c1315fdc67d6834219823255d3a92977ad5468f81a4e465ee50ababcbf46fd4f70131040beb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:31.680892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:31.681688) ========= 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=337fe3f4b1febe37b85fccc40000019e-1469875851.991445-360520278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:31.764765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 04:11:31.765516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 04:11:31.766213) ========= ========= Total master_lag: 0.20 =========