builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1469848200.26 results: success (0) buildid: 20160729173002 builduid: e9d918b701054606ae26893a54bc3942 revision: cf23addcfa4d9224a7d186481ecfb48194bb37be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.255584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.256014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.256311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.279753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.280060) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 20:10:00-- 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% 95.8M=0s 2016-07-29 20:10:00 (95.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.436275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.436558) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.486820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:00.487171) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf23addcfa4d9224a7d186481ecfb48194bb37be --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 cf23addcfa4d9224a7d186481ecfb48194bb37be --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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 20:10:00,680 truncating revision to first 12 chars 2016-07-29 20:10:00,680 Setting DEBUG logging. 2016-07-29 20:10:00,680 attempt 1/10 2016-07-29 20:10:00,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf23addcfa4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 20:10:00,995 unpacking tar archive at: fx-team-cf23addcfa4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:01.155822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:01.156100) ========= script_repo_revision: cf23addcfa4d9224a7d186481ecfb48194bb37be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:01.156504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:01.156773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 20:10:01.166920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-29 20:10:01.167217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:01 INFO - MultiFileLogger online at 20160729 20:10:01 in /builds/slave/test 20:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:01 INFO - {'append_to_log': False, 20:10:01 INFO - 'base_work_dir': '/builds/slave/test', 20:10:01 INFO - 'blob_upload_branch': 'Fx-Team', 20:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:01 INFO - 'branch': 'Fx-Team', 20:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:01 INFO - 'config_files': ('talos/linux_config.py',), 20:10:01 INFO - 'default_actions': ('clobber', 20:10:01 INFO - 'read-buildbot-config', 20:10:01 INFO - 'download-and-extract', 20:10:01 INFO - 'populate-webroot', 20:10:01 INFO - 'create-virtualenv', 20:10:01 INFO - 'install', 20:10:01 INFO - 'run-tests'), 20:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:01 INFO - 'download_minidump_stackwalk': True, 20:10:01 INFO - 'download_symbols': 'ondemand', 20:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:01 INFO - 'installer_path': 'installer.exe', 20:10:01 INFO - 'log_level': 'info', 20:10:01 INFO - 'log_name': 'talos', 20:10:01 INFO - 'log_to_console': True, 20:10:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:01 INFO - 'opt_config_files': (), 20:10:01 INFO - 'pip_index': False, 20:10:01 INFO - 'sps_profile': False, 20:10:01 INFO - 'sps_profile_interval': 0, 20:10:01 INFO - 'suite': 'dromaeojs', 20:10:01 INFO - 'system_bits': '32', 20:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:01 INFO - 'title': 'talos-linux64-ix-036', 20:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:01 INFO - 'use_talos_json': True, 20:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:01 INFO - 'work_dir': 'build'} 20:10:01 INFO - [mozharness: 2016-07-30 03:10:01.450066Z] Running clobber step. 20:10:01 INFO - Running pre-action listener: _resource_record_pre_action 20:10:01 INFO - Running main action method: clobber 20:10:01 INFO - rmtree: /builds/slave/test/build 20:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:01 INFO - Running post-action listener: _resource_record_post_action 20:10:01 INFO - [mozharness: 2016-07-30 03:10:01.924172Z] Finished clobber step (success) 20:10:01 INFO - [mozharness: 2016-07-30 03:10:01.924273Z] Running read-buildbot-config step. 20:10:01 INFO - Running pre-action listener: _resource_record_pre_action 20:10:01 INFO - Running main action method: read_buildbot_config 20:10:01 INFO - Using buildbot properties: 20:10:01 INFO - { 20:10:01 INFO - "project": "", 20:10:01 INFO - "product": "firefox", 20:10:01 INFO - "script_repo_revision": "production", 20:10:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:10:01 INFO - "repository": "", 20:10:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:10:01 INFO - "buildid": "20160729173002", 20:10:01 INFO - "pgo_build": "True", 20:10:01 INFO - "basedir": "/builds/slave/test", 20:10:01 INFO - "buildnumber": 325, 20:10:01 INFO - "slavename": "talos-linux64-ix-036", 20:10:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:10:01 INFO - "platform": "ubuntu64_hw", 20:10:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:10:01 INFO - "branch": "fx-team", 20:10:01 INFO - "repo_path": "integration/fx-team", 20:10:01 INFO - "revision": "cf23addcfa4d9224a7d186481ecfb48194bb37be", 20:10:01 INFO - "stage_platform": "linux64-pgo", 20:10:01 INFO - "builduid": "e9d918b701054606ae26893a54bc3942", 20:10:01 INFO - "slavebuilddir": "test" 20:10:01 INFO - } 20:10:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:10:01 INFO - Running post-action listener: _resource_record_post_action 20:10:01 INFO - [mozharness: 2016-07-30 03:10:01.927021Z] Finished read-buildbot-config step (success) 20:10:01 INFO - [mozharness: 2016-07-30 03:10:01.927112Z] Running download-and-extract step. 20:10:01 INFO - Running pre-action listener: _resource_record_pre_action 20:10:01 INFO - Running main action method: download_and_extract 20:10:01 INFO - mkdir: /builds/slave/test/build/tests 20:10: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')]} 20:10:01 INFO - https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:05 INFO - Downloaded 1361 bytes. 20:10:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:10:05 INFO - Using the following test package requirements: 20:10:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:10:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:10:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'jsshell-linux-x86_64.zip'], 20:10:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:10:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:10:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:10:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:10:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:10:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:05 INFO - https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:11 INFO - Downloaded 24330492 bytes. 20:10:11 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'] 20:10:11 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 20:10:12 INFO - Return code: 0 20:10:12 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 20:10:12 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')]} 20:10:12 INFO - https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:15 INFO - Downloaded 24330492 bytes. 20:10:15 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'] 20:10:15 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 20:10:16 INFO - Return code: 0 20:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:16 INFO - https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:18 INFO - Downloaded 14413725 bytes. 20:10:18 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'] 20:10:18 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 20:10:18 INFO - Return code: 0 20:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:18 INFO - https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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 20:10:19 INFO - Downloaded 61024493 bytes. 20:10:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:10:19 INFO - mkdir: /builds/slave/test/properties 20:10:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:10:19 INFO - Writing to file /builds/slave/test/properties/build_url 20:10:19 INFO - Contents: 20:10:19 INFO - build_url:https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:10:20 INFO - Running post-action listener: _resource_record_post_action 20:10:20 INFO - Running post-action listener: set_extra_try_arguments 20:10:20 INFO - [mozharness: 2016-07-30 03:10:20.418474Z] Finished download-and-extract step (success) 20:10:20 INFO - [mozharness: 2016-07-30 03:10:20.418616Z] Running populate-webroot step. 20:10:20 INFO - Running pre-action listener: _resource_record_pre_action 20:10:20 INFO - Running main action method: populate_webroot 20:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:10:20 INFO - '--tppagecycles', 20:10:20 INFO - '7'], 20:10:20 INFO - 'tests': ['tsvgm']}}, 20:10:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:10:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:10:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:10:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:10:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['damp', 'tps']}, 20:10:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'tests': ['damp', 'tps']}, 20:10:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['dromaeo_dom']}, 20:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:10:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['basic_compositor_video']}, 20:10:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:10:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'other-e10s': {'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['a11yr', 20:10:20 INFO - 'ts_paint', 20:10:20 INFO - 'tpaint', 20:10:20 INFO - 'sessionrestore', 20:10:20 INFO - 'sessionrestore_no_auto_restore', 20:10:20 INFO - 'tabpaint']}, 20:10:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['tsvgx', 20:10:20 INFO - 'tsvgr_opacity', 20:10:20 INFO - 'tart', 20:10:20 INFO - 'tscrollx', 20:10:20 INFO - 'cart']}, 20:10:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:10:20 INFO - 'tsvgr_opacity', 20:10:20 INFO - 'tart', 20:10:20 INFO - 'tscrollx', 20:10:20 INFO - 'cart']}, 20:10:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'talos_options': ['--disable-e10s'], 20:10:20 INFO - 'tests': ['tp5o']}, 20:10:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'tests': ['tp5o']}, 20:10:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'talos_options': ['--disable-e10s', 20:10:20 INFO - '--xperf_path', 20:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:20 INFO - 'tests': ['tp5n']}, 20:10:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:20 INFO - 'talos_options': ['--xperf_path', 20:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:20 INFO - 'tests': ['tp5n']}}, 20:10:20 INFO - 'talos.zip': {'path': '', 20:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:10:20 INFO - Running post-action listener: _resource_record_post_action 20:10:20 INFO - [mozharness: 2016-07-30 03:10:20.433454Z] Finished populate-webroot step (success) 20:10:20 INFO - [mozharness: 2016-07-30 03:10:20.433563Z] Running create-virtualenv step. 20:10:20 INFO - Running pre-action listener: _resource_record_pre_action 20:10:20 INFO - Running main action method: create_virtualenv 20:10:20 INFO - Creating virtualenv /builds/slave/test/build/venv 20:10:20 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 20:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:10:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:10:20 INFO - Using real prefix '/usr' 20:10:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:10:21 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:23 INFO - Installing pip.................done. 20:10:23 INFO - Return code: 0 20:10:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:23 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 20:10:23 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 20:10:23 INFO - Using env: {'DISPLAY': ':0', 20:10:23 INFO - 'HOME': '/home/cltbld', 20:10:23 INFO - 'LANG': 'en_US.UTF-8', 20:10:23 INFO - 'LANGUAGE': 'en_US:en', 20:10:23 INFO - 'LOGNAME': 'cltbld', 20:10:23 INFO - 'MAIL': '/var/mail/cltbld', 20:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:23 INFO - 'MOZ_NO_REMOTE': '1', 20:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:23 INFO - 'NO_EM_RESTART': '1', 20:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:23 INFO - 'PWD': '/builds/slave/test', 20:10:23 INFO - 'SHELL': '/bin/bash', 20:10:23 INFO - 'SHLVL': '1', 20:10:23 INFO - 'TERM': 'linux', 20:10:23 INFO - 'TMOUT': '86400', 20:10:23 INFO - 'USER': 'cltbld', 20:10:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:23 INFO - '_': '/tools/buildbot/bin/python'} 20:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:23 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 20:10:23 INFO - Cleaning up... 20:10:23 INFO - Return code: 0 20:10:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:23 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 20:10:23 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 20:10:23 INFO - Using env: {'DISPLAY': ':0', 20:10:23 INFO - 'HOME': '/home/cltbld', 20:10:23 INFO - 'LANG': 'en_US.UTF-8', 20:10:23 INFO - 'LANGUAGE': 'en_US:en', 20:10:23 INFO - 'LOGNAME': 'cltbld', 20:10:23 INFO - 'MAIL': '/var/mail/cltbld', 20:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:23 INFO - 'MOZ_NO_REMOTE': '1', 20:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:23 INFO - 'NO_EM_RESTART': '1', 20:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:23 INFO - 'PWD': '/builds/slave/test', 20:10:23 INFO - 'SHELL': '/bin/bash', 20:10:23 INFO - 'SHLVL': '1', 20:10:23 INFO - 'TERM': 'linux', 20:10:23 INFO - 'TMOUT': '86400', 20:10:23 INFO - 'USER': 'cltbld', 20:10:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:23 INFO - '_': '/tools/buildbot/bin/python'} 20:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:23 INFO - Downloading/unpacking psutil>=3.1.1 20:10:23 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 20:10:23 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 20:10:23 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 20:10:23 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 20:10:23 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 20:10:23 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 20:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:25 INFO - Installing collected packages: psutil 20:10:26 INFO - Running setup.py install for psutil 20:10:26 INFO - building 'psutil._psutil_linux' extension 20:10:26 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 20:10:26 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 20:10:26 INFO - building 'psutil._psutil_posix' extension 20:10:26 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 20:10:27 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 20:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:28 INFO - Successfully installed psutil 20:10:28 INFO - Cleaning up... 20:10:28 INFO - Return code: 0 20:10:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:10:28 INFO - Using env: {'DISPLAY': ':0', 20:10:28 INFO - 'HOME': '/home/cltbld', 20:10:28 INFO - 'LANG': 'en_US.UTF-8', 20:10:28 INFO - 'LANGUAGE': 'en_US:en', 20:10:28 INFO - 'LOGNAME': 'cltbld', 20:10:28 INFO - 'MAIL': '/var/mail/cltbld', 20:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:28 INFO - 'MOZ_NO_REMOTE': '1', 20:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:28 INFO - 'NO_EM_RESTART': '1', 20:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:28 INFO - 'PWD': '/builds/slave/test', 20:10:28 INFO - 'SHELL': '/bin/bash', 20:10:28 INFO - 'SHLVL': '1', 20:10:28 INFO - 'TERM': 'linux', 20:10:28 INFO - 'TMOUT': '86400', 20:10:28 INFO - 'USER': 'cltbld', 20:10:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:28 INFO - '_': '/tools/buildbot/bin/python'} 20:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:10:30 INFO - Installing collected packages: mozsystemmonitor 20:10:30 INFO - Running setup.py install for mozsystemmonitor 20:10:30 INFO - Successfully installed mozsystemmonitor 20:10:30 INFO - Cleaning up... 20:10:30 INFO - Return code: 0 20:10:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:10:30 INFO - Using env: {'DISPLAY': ':0', 20:10:30 INFO - 'HOME': '/home/cltbld', 20:10:30 INFO - 'LANG': 'en_US.UTF-8', 20:10:30 INFO - 'LANGUAGE': 'en_US:en', 20:10:30 INFO - 'LOGNAME': 'cltbld', 20:10:30 INFO - 'MAIL': '/var/mail/cltbld', 20:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:30 INFO - 'MOZ_NO_REMOTE': '1', 20:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:30 INFO - 'NO_EM_RESTART': '1', 20:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:30 INFO - 'PWD': '/builds/slave/test', 20:10:30 INFO - 'SHELL': '/bin/bash', 20:10:30 INFO - 'SHLVL': '1', 20:10:30 INFO - 'TERM': 'linux', 20:10:30 INFO - 'TMOUT': '86400', 20:10:30 INFO - 'USER': 'cltbld', 20:10:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:30 INFO - '_': '/tools/buildbot/bin/python'} 20:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:30 INFO - Downloading/unpacking jsonschema==2.5.1 20:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:10:32 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 20:10:32 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 20:10:32 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 20:10:32 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 20:10:32 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 20:10:32 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 20:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:32 INFO - warning: no files found matching '*.txt' 20:10:32 INFO - no previously-included directories found matching 'build' 20:10:32 INFO - no previously-included directories found matching 'dist' 20:10:32 INFO - no previously-included directories found matching '.git*' 20:10:32 INFO - Installing collected packages: jsonschema, functools32 20:10:32 INFO - Running setup.py install for functools32 20:10:32 INFO - warning: no files found matching '*.txt' 20:10:32 INFO - no previously-included directories found matching 'build' 20:10:32 INFO - no previously-included directories found matching 'dist' 20:10:32 INFO - no previously-included directories found matching '.git*' 20:10:32 INFO - Successfully installed jsonschema functools32 20:10:32 INFO - Cleaning up... 20:10:32 INFO - Return code: 0 20:10:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:32 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:32 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 20:10:32 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 20:10:32 INFO - Using env: {'DISPLAY': ':0', 20:10:32 INFO - 'HOME': '/home/cltbld', 20:10:32 INFO - 'LANG': 'en_US.UTF-8', 20:10:32 INFO - 'LANGUAGE': 'en_US:en', 20:10:32 INFO - 'LOGNAME': 'cltbld', 20:10:32 INFO - 'MAIL': '/var/mail/cltbld', 20:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:32 INFO - 'MOZ_NO_REMOTE': '1', 20:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:32 INFO - 'NO_EM_RESTART': '1', 20:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:32 INFO - 'PWD': '/builds/slave/test', 20:10:32 INFO - 'SHELL': '/bin/bash', 20:10:32 INFO - 'SHLVL': '1', 20:10:32 INFO - 'TERM': 'linux', 20:10:32 INFO - 'TMOUT': '86400', 20:10:32 INFO - 'USER': 'cltbld', 20:10:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:32 INFO - '_': '/tools/buildbot/bin/python'} 20:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:10:33 INFO - Cleaning up... 20:10:33 INFO - Return code: 0 20:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:10:33 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')]} 20:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:33 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')]} 20:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:33 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:33 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 20:10:33 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 20:10:33 INFO - Using env: {'DISPLAY': ':0', 20:10:33 INFO - 'HOME': '/home/cltbld', 20:10:33 INFO - 'LANG': 'en_US.UTF-8', 20:10:33 INFO - 'LANGUAGE': 'en_US:en', 20:10:33 INFO - 'LOGNAME': 'cltbld', 20:10:33 INFO - 'MAIL': '/var/mail/cltbld', 20:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:33 INFO - 'MOZ_NO_REMOTE': '1', 20:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:33 INFO - 'NO_EM_RESTART': '1', 20:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:33 INFO - 'PWD': '/builds/slave/test', 20:10:33 INFO - 'SHELL': '/bin/bash', 20:10:33 INFO - 'SHLVL': '1', 20:10:33 INFO - 'TERM': 'linux', 20:10:33 INFO - 'TMOUT': '86400', 20:10:33 INFO - 'USER': 'cltbld', 20:10:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:33 INFO - '_': '/tools/buildbot/bin/python'} 20:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:35 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 20:10:36 INFO - Downloading docopt-0.6.1.tar.gz 20:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:36 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:36 INFO - Running setup.py install for blobuploader 20:10:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:10:36 INFO - Running setup.py install for requests 20:10:36 INFO - Running setup.py install for docopt 20:10:36 INFO - Successfully installed blobuploader requests docopt 20:10:36 INFO - Cleaning up... 20:10:36 INFO - Return code: 0 20:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:36 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:36 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 20:10:36 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 20:10:36 INFO - Using env: {'DISPLAY': ':0', 20:10:36 INFO - 'HOME': '/home/cltbld', 20:10:36 INFO - 'LANG': 'en_US.UTF-8', 20:10:36 INFO - 'LANGUAGE': 'en_US:en', 20:10:36 INFO - 'LOGNAME': 'cltbld', 20:10:36 INFO - 'MAIL': '/var/mail/cltbld', 20:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:36 INFO - 'MOZ_NO_REMOTE': '1', 20:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:36 INFO - 'NO_EM_RESTART': '1', 20:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:36 INFO - 'PWD': '/builds/slave/test', 20:10:36 INFO - 'SHELL': '/bin/bash', 20:10:36 INFO - 'SHLVL': '1', 20:10:36 INFO - 'TERM': 'linux', 20:10:36 INFO - 'TMOUT': '86400', 20:10:36 INFO - 'USER': 'cltbld', 20:10:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:36 INFO - '_': '/tools/buildbot/bin/python'} 20:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:37 INFO - Running setup.py (path:/tmp/pip-FEkL9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:37 INFO - Running setup.py (path:/tmp/pip-M6XmIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:37 INFO - Running setup.py (path:/tmp/pip-KIEb1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:37 INFO - Running setup.py (path:/tmp/pip-f2fVrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:37 INFO - Running setup.py (path:/tmp/pip-61VEY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:37 INFO - Running setup.py (path:/tmp/pip-VJlKMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:37 INFO - Running setup.py (path:/tmp/pip-dQQKFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:37 INFO - Running setup.py (path:/tmp/pip-_rod26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:37 INFO - Running setup.py (path:/tmp/pip-JSZb6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:37 INFO - Running setup.py (path:/tmp/pip-4sgEMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:37 INFO - Running setup.py (path:/tmp/pip-_G9ziF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:37 INFO - Running setup.py (path:/tmp/pip-NVLL8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:37 INFO - Running setup.py (path:/tmp/pip-vCtyVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:38 INFO - Running setup.py (path:/tmp/pip-ociuIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:38 INFO - Running setup.py (path:/tmp/pip-zwGGaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:38 INFO - Running setup.py (path:/tmp/pip-NBAj5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:38 INFO - Running setup.py (path:/tmp/pip-9RLdSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:38 INFO - Running setup.py install for manifestparser 20:10:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:10:38 INFO - Running setup.py install for mozcrash 20:10:38 INFO - Running setup.py install for mozdebug 20:10:38 INFO - Running setup.py install for mozdevice 20:10:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:10:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:10:38 INFO - Running setup.py install for mozfile 20:10:38 INFO - Running setup.py install for mozhttpd 20:10:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:10:38 INFO - Running setup.py install for mozinfo 20:10:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:10:38 INFO - Running setup.py install for mozInstall 20:10:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Running setup.py install for mozleak 20:10:39 INFO - Running setup.py install for mozlog 20:10:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Running setup.py install for moznetwork 20:10:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Running setup.py install for mozprocess 20:10:39 INFO - Running setup.py install for mozprofile 20:10:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Running setup.py install for mozrunner 20:10:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:10:39 INFO - Running setup.py install for mozscreenshot 20:10:39 INFO - Running setup.py install for moztest 20:10:39 INFO - Running setup.py install for mozversion 20:10:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:10:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:40 INFO - Cleaning up... 20:10:40 INFO - Return code: 0 20:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:40 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')]} 20:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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')]} 20:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:40 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 20:10:40 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 20:10:40 INFO - Using env: {'DISPLAY': ':0', 20:10:40 INFO - 'HOME': '/home/cltbld', 20:10:40 INFO - 'LANG': 'en_US.UTF-8', 20:10:40 INFO - 'LANGUAGE': 'en_US:en', 20:10:40 INFO - 'LOGNAME': 'cltbld', 20:10:40 INFO - 'MAIL': '/var/mail/cltbld', 20:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:40 INFO - 'MOZ_NO_REMOTE': '1', 20:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:40 INFO - 'NO_EM_RESTART': '1', 20:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:40 INFO - 'PWD': '/builds/slave/test', 20:10:40 INFO - 'SHELL': '/bin/bash', 20:10:40 INFO - 'SHLVL': '1', 20:10:40 INFO - 'TERM': 'linux', 20:10:40 INFO - 'TMOUT': '86400', 20:10:40 INFO - 'USER': 'cltbld', 20:10:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:40 INFO - '_': '/tools/buildbot/bin/python'} 20:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:40 INFO - Running setup.py (path:/tmp/pip-CrtUN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:40 INFO - Running setup.py (path:/tmp/pip-tqWT0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:40 INFO - Running setup.py (path:/tmp/pip-qAYAiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:40 INFO - Running setup.py (path:/tmp/pip-IFsoDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:40 INFO - Running setup.py (path:/tmp/pip-_PJI7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:40 INFO - Running setup.py (path:/tmp/pip-RKOoWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:40 INFO - Running setup.py (path:/tmp/pip-0od8Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:40 INFO - Running setup.py (path:/tmp/pip-0vNF68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:40 INFO - Running setup.py (path:/tmp/pip-8Bj4Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:40 INFO - Running setup.py (path:/tmp/pip-B4_Mor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:40 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)) 20:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:40 INFO - Running setup.py (path:/tmp/pip-wtCOw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:41 INFO - Running setup.py (path:/tmp/pip-sV6E4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:41 INFO - Running setup.py (path:/tmp/pip-jSB06J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:41 INFO - Running setup.py (path:/tmp/pip-Fltz3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:41 INFO - Running setup.py (path:/tmp/pip-yJVZ8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:41 INFO - Running setup.py (path:/tmp/pip-FrN3mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:41 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)) 20:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:41 INFO - Running setup.py (path:/tmp/pip-0Iwy7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:41 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)) 20:10:41 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)) 20:10:41 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)) 20:10:41 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)) 20:10:41 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)) 20:10:41 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)) 20:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:43 INFO - Downloading blessings-1.6.tar.gz 20:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:43 INFO - Installing collected packages: blessings 20:10:43 INFO - Running setup.py install for blessings 20:10:43 INFO - Successfully installed blessings 20:10:43 INFO - Cleaning up... 20:10:43 INFO - Return code: 0 20:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:43 INFO - Reading from file tmpfile_stdout 20:10:43 INFO - Current package versions: 20:10:43 INFO - argparse == 1.2.1 20:10:43 INFO - blessings == 1.6 20:10:43 INFO - blobuploader == 1.2.4 20:10:43 INFO - docopt == 0.6.1 20:10:43 INFO - functools32 == 3.2.3-2 20:10:43 INFO - jsonschema == 2.5.1 20:10:43 INFO - manifestparser == 1.1 20:10:43 INFO - mozInstall == 1.12 20:10:43 INFO - mozcrash == 0.17 20:10:43 INFO - mozdebug == 0.1 20:10:43 INFO - mozdevice == 0.48 20:10:43 INFO - mozfile == 1.2 20:10:43 INFO - mozhttpd == 0.7 20:10:43 INFO - mozinfo == 0.9 20:10:43 INFO - mozleak == 0.1 20:10:43 INFO - mozlog == 3.3 20:10:43 INFO - moznetwork == 0.27 20:10:43 INFO - mozprocess == 0.23 20:10:43 INFO - mozprofile == 0.28 20:10:43 INFO - mozrunner == 6.12 20:10:43 INFO - mozscreenshot == 0.1 20:10:43 INFO - mozsystemmonitor == 0.3 20:10:43 INFO - moztest == 0.7 20:10:43 INFO - mozversion == 1.4 20:10:43 INFO - psutil == 3.1.1 20:10:43 INFO - requests == 1.2.3 20:10:43 INFO - wsgiref == 0.1.2 20:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:43 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 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:43 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 20:10:43 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 20:10:43 INFO - Using env: {'DISPLAY': ':0', 20:10:43 INFO - 'HOME': '/home/cltbld', 20:10:43 INFO - 'LANG': 'en_US.UTF-8', 20:10:43 INFO - 'LANGUAGE': 'en_US:en', 20:10:43 INFO - 'LOGNAME': 'cltbld', 20:10:43 INFO - 'MAIL': '/var/mail/cltbld', 20:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:43 INFO - 'MOZ_NO_REMOTE': '1', 20:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:43 INFO - 'NO_EM_RESTART': '1', 20:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:43 INFO - 'PWD': '/builds/slave/test', 20:10:43 INFO - 'SHELL': '/bin/bash', 20:10:43 INFO - 'SHLVL': '1', 20:10:43 INFO - 'TERM': 'linux', 20:10:43 INFO - 'TMOUT': '86400', 20:10:43 INFO - 'USER': 'cltbld', 20:10:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:43 INFO - '_': '/tools/buildbot/bin/python'} 20:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 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)) 20:10:44 INFO - Cleaning up... 20:10:44 INFO - Return code: 0 20:10:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2964180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', '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 20:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:10:44 INFO - Using env: {'DISPLAY': ':0', 20:10:44 INFO - 'HOME': '/home/cltbld', 20:10:44 INFO - 'LANG': 'en_US.UTF-8', 20:10:44 INFO - 'LANGUAGE': 'en_US:en', 20:10:44 INFO - 'LOGNAME': 'cltbld', 20:10:44 INFO - 'MAIL': '/var/mail/cltbld', 20:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:44 INFO - 'MOZ_NO_REMOTE': '1', 20:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:44 INFO - 'NO_EM_RESTART': '1', 20:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:44 INFO - 'PWD': '/builds/slave/test', 20:10:44 INFO - 'SHELL': '/bin/bash', 20:10:44 INFO - 'SHLVL': '1', 20:10:44 INFO - 'TERM': 'linux', 20:10:44 INFO - 'TMOUT': '86400', 20:10:44 INFO - 'USER': 'cltbld', 20:10:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:44 INFO - '_': '/tools/buildbot/bin/python'} 20:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:10:44 INFO - Cleaning up... 20:10:44 INFO - Return code: 0 20:10:44 INFO - Running post-action listener: _resource_record_post_action 20:10:44 INFO - Running post-action listener: _start_resource_monitoring 20:10:44 INFO - Starting resource monitoring. 20:10:44 INFO - [mozharness: 2016-07-30 03:10:44.351913Z] Finished create-virtualenv step (success) 20:10:44 INFO - [mozharness: 2016-07-30 03:10:44.352347Z] Running install step. 20:10:44 INFO - Running pre-action listener: _resource_record_pre_action 20:10:44 INFO - Running main action method: install 20:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:44 INFO - Reading from file tmpfile_stdout 20:10:44 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:44 INFO - Reading from file tmpfile_stdout 20:10:44 INFO - Output received: 20:10:44 INFO - Usage: mozinstall [options] installer 20:10:44 INFO - Options: 20:10:44 INFO - -h, --help show this help message and exit 20:10:44 INFO - -d DEST, --destination=DEST 20:10:44 INFO - Directory to install application into. [default: 20:10:44 INFO - "/builds/slave/test"] 20:10:44 INFO - --app=APP Application being installed. [default: firefox] 20:10:44 INFO - mkdir: /builds/slave/test/build/application 20:10:44 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'] 20:10:44 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 20:11:02 INFO - Reading from file tmpfile_stdout 20:11:02 INFO - Output received: 20:11:02 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:02 INFO - Running post-action listener: _resource_record_post_action 20:11:02 INFO - [mozharness: 2016-07-30 03:11:02.090681Z] Finished install step (success) 20:11:02 INFO - [mozharness: 2016-07-30 03:11:02.090963Z] Running run-tests step. 20:11:02 INFO - Running pre-action listener: _resource_record_pre_action 20:11:02 INFO - Running main action method: run_tests 20:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:02 INFO - Python 2.7.3 20:11:02 INFO - Return code: 0 20:11:02 INFO - grabbing minidump binary from tooltool 20:11:02 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')]} 20:11:02 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 0x29623b0>, '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 0x29632b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2963740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:02 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 20:11:02 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 20:11:02 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 20:11:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:02 INFO - Return code: 0 20:11:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 20:11:02 INFO - Using env: {'DISPLAY': ':0', 20:11:02 INFO - 'HOME': '/home/cltbld', 20:11:02 INFO - 'LANG': 'en_US.UTF-8', 20:11:02 INFO - 'LANGUAGE': 'en_US:en', 20:11:02 INFO - 'LOGNAME': 'cltbld', 20:11:02 INFO - 'MAIL': '/var/mail/cltbld', 20:11:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:02 INFO - 'MOZ_NO_REMOTE': '1', 20:11:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:02 INFO - 'NO_EM_RESTART': '1', 20:11:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:02 INFO - 'PWD': '/builds/slave/test', 20:11:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:02 INFO - 'SHELL': '/bin/bash', 20:11:02 INFO - 'SHLVL': '1', 20:11:02 INFO - 'TERM': 'linux', 20:11:02 INFO - 'TMOUT': '86400', 20:11:02 INFO - 'USER': 'cltbld', 20:11:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597', 20:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:02 INFO - '_': '/tools/buildbot/bin/python'} 20:11:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:11:02 INFO - mozversion application_buildid: 20160729173002 20:11:02 INFO - mozversion application_changeset: cf23addcfa4d9224a7d186481ecfb48194bb37be 20:11:02 INFO - mozversion application_display_name: Nightly 20:11:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:02 INFO - mozversion application_name: Firefox 20:11:02 INFO - mozversion application_remotingname: firefox 20:11:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:11:02 INFO - mozversion application_vendor: Mozilla 20:11:02 INFO - mozversion application_version: 50.0a1 20:11:02 INFO - mozversion platform_buildid: 20160729173002 20:11:02 INFO - mozversion platform_changeset: cf23addcfa4d9224a7d186481ecfb48194bb37be 20:11:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:11:02 INFO - mozversion platform_version: 50.0a1 20:11:02 INFO - using testdate: 1469848262 20:11:02 INFO - actual date: 1469848262 20:11:02 INFO - starting webserver on 'localhost:41165' 20:11:02 INFO - SUITE-START | Running 2 tests 20:11:02 INFO - TEST-START | dromaeo_css 20:11:02 INFO - operating with platform_type : linux_ 20:11:02 INFO - Initialising browser for dromaeo_css test... 20:11:02 INFO - TEST-INFO | started process 9529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVio_z/profile http://localhost:41165/getInfo.html) 20:11:05 INFO - PROCESS | 9529 | JavaScript error: , line 0: uncaught exception: undefined 20:11:06 INFO - PROCESS | 9529 | __metrics Screen width/height:1600/1200 20:11:06 INFO - PROCESS | 9529 | colorDepth:24 20:11:06 INFO - PROCESS | 9529 | Browser inner width/height: 1024/697 20:11:06 INFO - PROCESS | 9529 | __metrics 20:11:07 INFO - PROCESS | 9529 | 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" 20:11:07 INFO - PROCESS | 9529 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:08 INFO - PROCESS | 9529 | console.error: PushService: 20:11:08 INFO - PROCESS | 9529 | stateChangeProcessEnqueue: Error transitioning state 20:11:08 INFO - PROCESS | 9529 | UnknownError 20:11:08 INFO - TEST-INFO | 9529: exit 0 20:11:08 INFO - Browser initialized. 20:11:08 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:08 INFO - TEST-INFO | started process 9609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVio_z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:20 INFO - PROCESS | 9609 | RSS: Main: 157839360 20:11:20 INFO - PROCESS | 9609 | 20:12:11 INFO - PROCESS | 9609 | 1469848331228 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] 20:14:20 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41165/tests/dromaeo/cssquery-ext.html) 20:14:21 INFO - PROCESS | 9609 | RSS: Main: 271654912 20:14:21 INFO - PROCESS | 9609 | 20:17:23 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-ext.html (next: http://localhost:41165/tests/dromaeo/cssquery-jquery.html) 20:17:24 INFO - PROCESS | 9609 | RSS: Main: 249806848 20:17:24 INFO - PROCESS | 9609 | 20:20:26 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41165/tests/dromaeo/cssquery-mootools.html) 20:20:26 INFO - PROCESS | 9609 | RSS: Main: 186286080 20:20:26 INFO - PROCESS | 9609 | 20:23:28 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41165/tests/dromaeo/cssquery-prototype.html) 20:23:29 INFO - PROCESS | 9609 | RSS: Main: 233017344 20:23:29 INFO - PROCESS | 9609 | 20:26:32 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41165/tests/dromaeo/cssquery-yui.html) 20:26:32 INFO - PROCESS | 9609 | RSS: Main: 183656448 20:26:32 INFO - PROCESS | 9609 | 20:29:35 INFO - PROCESS | 9609 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-yui.html (next: http://localhost:41165/tests/dromaeo/cssquery-dojo.html) 20:29:36 INFO - PROCESS | 9609 | RSS: Main: 279023616 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | __start_tp_report 20:29:36 INFO - PROCESS | 9609 | _x_x_mozilla_page_load 20:29:36 INFO - PROCESS | 9609 | _x_x_mozilla_page_load_details 20:29:36 INFO - PROCESS | 9609 | |i|pagename|runs| 20:29:36 INFO - PROCESS | 9609 | |0;dojo.html;3057.357954829487;3069.769767267455;3083.1058992892063;3099.845007749612;3116.11190810619;5212.635115541904;5264.947350526493;5357.8748462822805;5432.239486471892;5456.945430545688;5348.411674715788;5360.91958620621;5399.244105825188;5402.108652072413;5460.754266058027;4831.299461578078;4875.756212189394;4902.460729319772;4920.3111564381015;5031.597472202233;4937.679050861682;4959.900801983958;4983.22759972203;4995.850124496253;5000.574951129159;4790.520947905182;4797.9520204797855;4857;4858.125537403266;4939.506049395068;4885.584725298354;4897.363342765453;4900.191468407708;4907.411110666707;4965.773868746758;4910.607151427877;4933.309336692866;4941.777620007072;4948.331975183341;4950;5234.110201265794;5295.073362161606;5392.110301800199;5406.972965135188;5454.672719636795;5713.942860571424;5729.28383952006;5775.16260142277;5784.768609255625;5790.7683692652245;5742.138679198112;5768.682722450264;5819.912701309484;5824.417558244184;5829.067349224146;5149.253358263069;5288.312519372457;5315.830517286191;5342.732863356817;5436.3476382834315;5967.283925928917;5973.880522389528;5974.3428222895445;5977.402259774075;5980.760769569256;5714.857128571819;5719.256496655408;5724;5725.77096916127;5729.398413166641;5560.582956278296;5583.637063590853;5592.440755924375;5599.7480113394995;5706.572007099484;5632.295963004624;5633.0987042073075;5634;5637.548996080303;5665.688387138664;5635.605507614509;5645.379008309083;5708.971455142698;5710.086386178192;5712.971435142797;4296.0548679290505;4332.67504937131;4345.369921361448;4362.716423432466;4387;3900.7659540427667;3907.765534067908;3910.7458015228917;3932.8230229639735;3951.091249012743;5436.266104075979;5440.891182176334;5442.8911421771345;5449.754761035763;5460.34475862899;5576.302962129734;5686.630369026;5717.571182161355;5727.570432217601;5810.099434587646;5453.509184173444;5455.18172274162;5457.181422786534;5459.39946605881;5482.588805839578;4890.755462226874;4897.730624815669;4898;4905.337779399807;4941.555260026615;5785.739641716049;5873.618214816023;5919.644821310735;5920.644761314249;5973.641581505037;5736.483716465538;5738.397468265772;5741.081426971665;5741.942580574308;5780.075187969905;5928.762849485972;5939.940600594112;5940.287165540163;5944.019236826049;5945.137954996588;5429;5558.805441809517;5564.972175139098;5584.888302234014;5614.915776263278;5713.571482138939;5751.712414379181;5756.568257380797;5764.654120752768;5801.709914504342;5581.079121944996;5583.581231407579;5590.273264475755;5593.0771422716425;5596.468335508121;5462.6995515247045;5562.249096371938;5579.246801681721;5589.077802162597;5615.691136987505;5586.301712285965;5594.356648985256;5594.440555944373;5594.552435805044;5635.633683810539;5645.68948707825;5680.573956953162;5737.770489180553;5742.339630942495;5746.885062298814;5432.103702889137;5455.481729235717;5459.863503412446;5549.472800084147;5552.972235138798 20:29:36 INFO - PROCESS | 9609 | |1;ext.html;591.6095377051147;621.8103478439077;629.1286568103176;632.197109670718;647.6308504152632;43323.13353732923;44494.777526112324;44523;44602.33096503551;48718.26922596164;44812.3278150828;45254.54745452553;45257.54742452574;45342.319865201964;45385;8953.507557084342;9070.138336858021;9128.771780705469;9137;9142.222911052535;8886.955565222164;8889.511076890769;8969.686060987866;8977;8980.281577473786;8905;8949.507777072258;8949.686760963368;9029.59366828491;9047.773805654846;8965.865512017324;8995.5052472114;9024.909750902472;9032.051634578405;9037.186653201177;8868.15752503511;8918.866217006751;8927.330450216195;8937.50843703596;8943.284537237005;43017.56982430167;43330;43411;43447.56552434467;43480.13039739219;3388.695017448417;3420.0936751760805;3427.160345715291;3859.4017927221325;4046.210988857174;33228.50157247619;33537.496937545955;33700;33942.83028584866;34365.656343436494;4330.328799036154;4414.161309351213;4414.889627759299;4517.638588912879;4519.706219095749;355928;362156;363358;482728.5863570695;483592;62716.37283627196;62917.685411572646;63153.36846631567;63260.367396326365;63263.36736632667;56689.149662755095;63570.36429635737;65183.67408162929;66347.33652663411;66823.99056056653;14645.48740794067;14655.267236638125;14710.632234194016;14827.555173344817;14840.40638374453;10696.304740191863;10749.140068794477;10768.892311076788;10777.083947864363;10889.83665245022;17110.657786844193;19061;19300.71048934267;19470.750151540713;20065.29771457992;7110.329792569851;7264.367816091954;7297.817554561178;7399;7463.104427468738;954.9713508594754;1061.1881910338598;1071.5767271927546;1092.2136062035322;1116.3859877067744;29844.253893652833;30004.84997574998;30236.395272094436;30343.69656303453;30384.240393990327;1093.147345070846;1094.2504384496644;1116.821308590638;1141.6232643227715;1196.342011893455;16071.517854464384;16275.348986040426;16412;16535.421260255833;16584.83415165857;583062;587644;590137;590273;591945;59921.40078599245;60132;60132.699336503916;60269;60422.69788651029;1290.251654040654;1356.8982326325565;1370.1778932640536;1371.3143428285857;1375.5116933488669;30126;30843.845780770953;30964.535531966587;32189.517157242193;32239.389946900614;52462.737686311324;52650;52778;52821.7358913203;52886.73556632346;463398;464021;464217;466007;470184;24986.250412487654;27160.72839271582;28651.426971460038;28906.42187156203;28989.56515652309;43109.56890431181;47916.281255780494;48019;48119.518804812906;48310.27534587054;40620.593794062865;40903.795481022404;41943;42257.78871105625;42511;40725.796371017954;40750.79624601858;41143.7942810296;42155.789221054925;42302.36546451744;39753.40369894396;40814.59185408108;42126.78936605297;42186.78906605447;44317.556824432635;34164.658353417144;37817.81091094527;38060.42909356417;38152;38599.228015440094;26702.866485667448;27110.457790844466;27344.31639208956;27475.86262068677;27933.16200513988 20:29:36 INFO - PROCESS | 9609 | |2;jquery.html;376.7438142063396;387.1675896821831;394.27847039916946;400.84968136948646;415.93760935859615;14171.503997360094;17502.81214848144;19472.610547789034;19776.505587360323;19948.90025549872;17863.553411164696;17880.37418690346;17904.462866114005;18055.81944180558;18100.185491652875;4279.700420970534;5624.409437009127;5811.331696854873;5815.5638327125425;5817.040188368936;5162.354705661793;6534.705938232767;6622.53642245043;6693.062971184038;6693.297203793604;6350.460210882081;6432.195975503062;6478.255000674935;6650.434713049397;6664.266930637626;6298.3701629837105;6517.446017088553;6541.771038013647;6552.525681721599;6553.410193082598;5671.6597004179885;5713.257276554063;5740.1102829061565;5755.539556835443;5758.2514273144225;23286.883565582233;23644.172453964027;23803.40491487727;23825.61743825621;24015.15946941866;2428;2528.6080657497932;2577.0336123953516;2978;3055.3125546752026;14338.283085845665;14833.70332593353;14916.105033698013;15515.146666933315;15599.532014039596;1774.8047714751367;1841.815818418161;1872.2136702584946;1901.657701613709;1942.4852414110271;74308.62845685791;75804;81894.59052704758;87227.56386218092;88465.55767221123;10399.376037437778;10493.475326233658;10912.181586381053;10955;11060.612878549373;15545.37818487248;15594.220288985505;15605.765913511306;15613.84386156124;15637.13995730223;7320.67056982437;7442.359462385899;7571.3564347031115;7627.580483073484;7652.120006199359;7037.92962070383;7138.785836424916;7278.890816637755;7293.0519032525435;7295.161056478467;4378.978105109454;4493.887652808706;4565.794539245742;4708.858734237979;4721.3390125382475;1821.8815776974454;1918.5587314917648;1953.765548134233;1970.9802901970797;2029.84776141787;834.586879494642;926.7358802741186;954.6420092465326;968.7432830299977;975.0980343182528;18292.908535457504;19373.4187974361;19594.70607940882;20437.284695035603;20565.38303850887;984.2962281968427;995.4674249276602;997.3118548201718;1020.2195320579763;1027.5016616940777;10497.62974361526;11142.721431964266;11215.383153926612;11282.94358528202;11338.376389298503;567861;568841;577402;581530;582908;59773.701131494934;63532;97351;98408;103730;1011.206203130539;1045.8849526552226;1084.38732116354;1108.706192858893;1118.2842980492492;17228.224729887435;17341.56646083858;17933.730994035363;17991.910040449715;18256.634867302313;40484.3927341096;42029.36955945602;45107.323390148515;45736.771316143204;46191.76904115458;55865;56556.71721641366;59075;62704.68647656732;64095;8126;8185;8200.466969646954;8210.507369557607;8445.1977062179;12278.508859645513;12768.74462510726;12783.680407989874;13065.738685226432;13157.276349800853;11660;11865.347405892759;11912.76174476523;12042.976347010603;12453.564125255572;11908.583199587973;11950.34273114987;11978.76042479163;12328.383580821102;12468.942624466861;11809.645710628694;11841.467133979164;11957.641270761891;12089;12226.938865305972;8177.264046235868;8391.706290279812;8547;8554.529500877512;8605.483670979762;11664.825027624423;11670.824937625772;11717.648470545897;11738.647840564796;11834.940825295818 20:29:36 INFO - PROCESS | 9609 | |3;mootools.html;1379.5516457151416;1482.058892603197;1531.9080855148693;1643.55623981525;1770.0530216334255;8558.871616925744;8825.602847871845;8847.734567962956;9000.729978100651;9005.684801031965;8952.418092823962;9039.954800226005;9040.186383225508;9040.683576074838;9045.3668243223;2363.1256435118985;2396.4488167721347;2398.6761787158684;2400.9639855402183;2402.027178992511;2366.325597204797;2400.339906525711;2420.491696743677;2421.406755344943;2422.0917156066475;2365.8462199957034;2370.881455927197;2388.653645221442;2443.951120977579;2449.865257410842;2314.7685231476885;2319.675245465636;2325.476767727256;2325.988370058147;2385.7017872765905;2346.3195673254736;2376.192094687797;2381.30942026812;2383.0467812874817;2383.4518060846103;8847.823043539158;9001.369904106716;9060.184583387527;9062.77343066422;9067.954660226656;5199.66202196856;5350.678959262418;5404.243405923174;5412.296401467784;5447.319085114361;3482.703970162539;3507.298540291926;3551.4140166872435;3553.34263161316;3570.0003998880356;1129.785340785248;1134.7163209197702;1138.59579849154;1169.7309618787642;1171.1567671276666;12447.626571202787;12546.309952952584;12639.304838233893;12668.17656852311;12673.683157921034;4719.95280047202;4829.613630909519;4896.608271338285;4982.153033984231;4991;10745.301555398873;10750.78498430027;10750.78498430027;10762.892371076188;10767.300125491818;5454.154606036071;5455.890882182334;5457;5457.2905522282645;5461.0716178249795;4390.846320378771;4760.262159365235;4879.341288926021;4919.385076865392;4995.9500404996215;4079.347304431277;4099.774512401847;4208.558101399371;4249.086446414036;4274.957250427518;1290.677330667333;1340.5710172744823;1351.108268542757;1363.1139759156626;1366.590022993098;1003.1373019203479;1004.5278719002057;1024.8770147582338;1030.299396410433;1048.7849990751877;6072.876517844213;6101.7559297627595;6146.508279337642;6278.340774218641;6294.968525157345;980.2550061952967;984.4683870709737;991.1971303244395;1011.5346940407347;1055.5408397347178;4100.1184745279315;4215.220184265921;4269.573042695705;4373.606375426227;4457.554244575516;10968.616098436676;11199.272047316897;11260.662180134608;11306.660800175843;11392.715182120513;11351.375674337825;11366.772664546828;11367.602133925273;11369.829452558219;11373.431328433546;8016.158303378178;8202.466839655403;8210.178982101743;8425.073241943504;8433.367497437717;6238.157848690369;6391.48868090561;6479.773207937699;6481.935180648133;6537.444317232898;9829.459379734184;9865.112139907444;9899.604015839574;9989.900100999188;10004.199664026715;10169.288149829441;10257.281990260908;10305;10487.842682359618;10592.205584581341;7337.926620733724;7987.600619968862;8072.143407016301;8209.302209312036;8248.216419440143;8901.777455563404;8933.553322333988;8945.821083578423;8957.955210224169;8963.282937365126;7816;7886.48737832062;8027.277545020743;8094.352451803959;8160.183981601793;7716.691332346643;7852.882206766789;7895.68417263303;7897.05235371759;7933.968584084032;7118.572885626879;7208.098987626547;7209.603471808891;7210.2789721027475;7220.494565380373;5348.1977703343255;5440.156775699773;5452.509274165344;5475.780968761205;5618.129189975561;5298.708571028476;5299.099153143898;5301.1783173608155;5349.518543331119;5429.511343979061 20:29:36 INFO - PROCESS | 9609 | |4;prototype.html;307.87223302329534;316.5568204513681;324.56832412890856;324.8424514110656;326.9901902942911;5191.948080519193;5242.08263553878;5246;5264.1051021326375;5278.261043453915;4924.458309585952;5021.874453138665;5026.723530205837;5036.622253331006;5205.947940520594;3949.2299001694682;4003.819828107742;4075.1849630073957;4098.8360465581345;4117.279476091687;4097.9510244877565;4114.485689288839;4140.296149654551;4151.252774500589;4162.521310049337;3867.7679339239594;4021.9798901005456;4035.6973227007943;4137.40007698885;4152.501699796028;4028.6172813582807;4043.65628921542;4062.8217816833085;4069.4302797608357;4076.5515793262716;3579.8926032219074;3590.425531914881;3592.1019745063736;3596.5684117906017;3599.3881040223223;4895.723488577828;5180.6891586504935;5187.792488300463;5190.273361729361;5206.635535512516;4609.976950115228;4619.607333376667;4624.676272660915;4631.907361852778;4663.090697314025;5430;5430.755615997289;5434.945650543484;5443.673379597237;5482.396936337;3836.290286297044;3890.144168282973;3893.4549163116903;3916.667083297923;3930.5479869815053;5584.972075139598;5590.664560126364;5666.744996475169;5679.914801277984;5709.457601527848;3953.545342285674;3958.802059897051;3962.663173630216;3984.6812255019527;3991.1219531702977;4042.171354872244;4043.7775922324554;4059.127287633173;4060.289449346412;4079.224947260011;4510.188166130128;4599.632029437637;4622.128038144557;4626.907461850744;4677.18149323867;5449.918251226235;5451.972740136353;5457.727113644302;5467.917981230285;5469.945300546943;1323.5963031275553;1386.383059538516;1394.2401391241797;1402.3689339797131;1403.6771542545068;918.6004088221645;930.9767255818523;947.1759569174862;953.4612943686794;953.6948176583427;5199.454057324002;5227.817026404057;5237.973810130925;5259.552938000236;5327.9733601331745;5574.554035677136;5583.944160558342;5592.412796656293;5592.496675299242;5602.803901863415;5136.178211486219;5365.22204280385;5371.865703357369;5379.973100134553;5404.540614047772;2969.198316454545;2995.5207166853197;2997.2057404787747;2999.145243605562;3015.2311160653894;5681.488666020078;5767.682777447197;5857.736401861926;5866.765329386777;5873.2658417697785;5681.4034526374135;5686.232358631614;5696.971515142398;5702.429757024347;5727.885442291131;5731.283589551306;5764.365919748824;5823.359430462561;5845.181674565564;5848.356680765112;5358;5586.217929489793;5600.85997850057;5600.971995139998;5608.495235428831;5524.309461317335;5546.168074788652;5548.834744703496;5587.776488940397;5624.465675760796;5565.916511252415;5793.159991801081;5793.188953546422;5794;5853.736581853742;3971.5035620547433;3974.5627980922654;3986.760794352232;4005.859794907164;4022.316206244887;5649.180868774087;5650.773969041193;5663.292088488939;5673.439804053918;5683.5453163747625;5242.7902883885745;5472.2338872557075;5481.862953426196;5550.417206193291;5558.805441809517;5448.618596698193;5453.409630425516;5471.124620060771;5474.534664553557;5511.200875873056;5193.883315087274;5239.318888544465;5363.517283444508;5419.593530485308;5470.234167216513;5461.208124821958;5489;5512.448755124456;5518.841043380935;5529.972350138223;5392.487713667196;5394.595405344537;5396.9730151348995;5458.426865179099;5485.778259804785 20:29:36 INFO - PROCESS | 9609 | |5;yui.html;740.1377395334432;743.788020414182;762.2910693055456;767.4474378447519;768.243280368837;14802.851971480282;15046.825601972432;15151.318190681419;15234.771478427818;16208.432704855333;14931.626709332271;15404.768928466083;15410.152441615735;15419.922900385482;15468.690626187497;817.7138001699402;834.5576844272546;835.8119423129808;836.3560058754755;836.477201748907;677.7661706711177;812.7358608452276;832.3382910586068;833.4041160570191;842.7008412013708;880.2034159086037;881.2025117268882;883.1565854608833;883.4964070479829;884.3765145572356;867.5748883047293;875.8335916175906;877.6006916852848;879.2262808728342;879.278991227194;513.7020528093734;619.1424876545972;632.2792017100509;632.5824955529329;638.3488841381765;15175.544733658007;15194.088354698642;15198.772018419733;15207.391704331814;15225;14146.151230926178;14401.927990360085;14672.70654586913;14724.116553006746;15063;13496;13642.727145457035;13727.794083088762;13817.861821381859;14320.355583998746;4453.599176074136;4464.486584042812;4490.943347322891;4527.275635898273;4560.612347950429;80381;80752.19247807506;80787.59606201931;81042;81120;11081.501332440059;11130.666080017612;11544.365059921785;11913.10651701126;12025.518979240733;21137.048832802255;21561.67657485139;21624.459388515097;21641.458963526038;21656.56686866254;8507.489550626982;8751.474911505331;8858.689945851864;8890.555472226362;8910.108989101167;4734.431868175841;4829.323894654751;4896.387951506062;5035.723035233097;5054.21659642756;3302.3725492156414;3376.74674399421;3381.5096810962273;3382.2728113455723;3384.6784555467193;582.5747204540625;594.6224147666263;599.9370066142992;607.325868286202;616.3713012726994;665.5208250059949;700.5236439221277;703.1070540413646;713.3080911515822;738.903942487484;8978.506182159914;9358.204552613104;9698.951505242429;9743.902560974442;9779.308967445491;625.2965413909352;637.8947473666885;661.3122352753179;688.9311068893071;716.4805516000962;4265;4283.850065247701;4318.740875547414;4352.804123814436;4450.910981780346;112204;112510;114619;117723;119221;100742;102724.48637756763;103325.25060620334;104480;107102;81103;83102.58448707718;83360;86109;87194.56402718072;8560.785980350542;8712.433691810013;8719.73840784752;8835.469871807712;8971.910280897107;51163.23255151101;51670;52244.47755522396;52459.95080098453;53428.46571534235;69122.88946997498;74664;78180;78299.21700783147;80173.5991320063;12112.636620901387;12231.571894983634;12250.387480625755;13052.15161014569;13087.934560327518;12881.742365152457;12950.740985180431;13037.934810325887;13433.261170635318;13662.590122296348;11964.940175299067;12200.145989780985;12233.877661223274;12271.447784849524;12711.682207944505;12099.11882190417;12231.327276999851;12232.87767122353;12238;12338.568150114703;11906.40467976615;12078.637640870787;12125.636230913087;12308.50765969387;12382.195157314745;9718.75703107428;10146.898531014594;10175.338602991078;10186.898131018892;10286.639967601099;9752.512374381395;10154.898451015692;10296;10297.588096476056;10306.072453479223 20:29:36 INFO - PROCESS | 9609 | __end_tp_report 20:29:36 INFO - PROCESS | 9609 | __start_cc_report 20:29:36 INFO - PROCESS | 9609 | _x_x_mozilla_cycle_collect,1023 20:29:36 INFO - PROCESS | 9609 | __end_cc_report 20:29:36 INFO - PROCESS | 9609 | __startTimestamp1469849376093__endTimestamp 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | ------- Summary: start ------- 20:29:36 INFO - PROCESS | 9609 | Number of tests: 6 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#0] dojo.html Cycles:165 Average:5329.77 Median:5558.81 stddev:605.09 (10.9%) stddev-sans-first:580.09 20:29:36 INFO - PROCESS | 9609 | Values: 3057.4 3069.8 3083.1 3099.8 3116.1 5212.6 5264.9 5357.9 5432.2 5456.9 5348.4 5360.9 5399.2 5402.1 5460.8 4831.3 4875.8 4902.5 4920.3 5031.6 4937.7 4959.9 4983.2 4995.9 5000.6 4790.5 4798.0 4857.0 4858.1 4939.5 4885.6 4897.4 4900.2 4907.4 4965.8 4910.6 4933.3 4941.8 4948.3 4950.0 5234.1 5295.1 5392.1 5407.0 5454.7 5713.9 5729.3 5775.2 5784.8 5790.8 5742.1 5768.7 5819.9 5824.4 5829.1 5149.3 5288.3 5315.8 5342.7 5436.3 5967.3 5973.9 5974.3 5977.4 5980.8 5714.9 5719.3 5724.0 5725.8 5729.4 5560.6 5583.6 5592.4 5599.7 5706.6 5632.3 5633.1 5634.0 5637.5 5665.7 5635.6 5645.4 5709.0 5710.1 5713.0 4296.1 4332.7 4345.4 4362.7 4387.0 3900.8 3907.8 3910.7 3932.8 3951.1 5436.3 5440.9 5442.9 5449.8 5460.3 5576.3 5686.6 5717.6 5727.6 5810.1 5453.5 5455.2 5457.2 5459.4 5482.6 4890.8 4897.7 4898.0 4905.3 4941.6 5785.7 5873.6 5919.6 5920.6 5973.6 5736.5 5738.4 5741.1 5741.9 5780.1 5928.8 5939.9 5940.3 5944.0 5945.1 5429.0 5558.8 5565.0 5584.9 5614.9 5713.6 5751.7 5756.6 5764.7 5801.7 5581.1 5583.6 5590.3 5593.1 5596.5 5462.7 5562.2 5579.2 5589.1 5615.7 5586.3 5594.4 5594.4 5594.6 5635.6 5645.7 5680.6 5737.8 5742.3 5746.9 5432.1 5455.5 5459.9 5549.5 5553.0 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#1] ext.html Cycles:180 Average:64501.45 Median:43370.50 stddev:131604.79 (303.4%) stddev-sans-first:131886.50 20:29:36 INFO - PROCESS | 9609 | Values: 591.6 621.8 629.1 632.2 647.6 43323.1 44494.8 44523.0 44602.3 48718.3 44812.3 45254.5 45257.5 45342.3 45385.0 8953.5 9070.1 9128.8 9137.0 9142.2 8887.0 8889.5 8969.7 8977.0 8980.3 8905.0 8949.5 8949.7 9029.6 9047.8 8965.9 8995.5 9024.9 9032.1 9037.2 8868.2 8918.9 8927.3 8937.5 8943.3 43017.6 43330.0 43411.0 43447.6 43480.1 3388.7 3420.1 3427.2 3859.4 4046.2 33228.5 33537.5 33700.0 33942.8 34365.7 4330.3 4414.2 4414.9 4517.6 4519.7 355928.0 362156.0 363358.0 482728.6 483592.0 62716.4 62917.7 63153.4 63260.4 63263.4 56689.1 63570.4 65183.7 66347.3 66824.0 14645.5 14655.3 14710.6 14827.6 14840.4 10696.3 10749.1 10768.9 10777.1 10889.8 17110.7 19061.0 19300.7 19470.8 20065.3 7110.3 7264.4 7297.8 7399.0 7463.1 955.0 1061.2 1071.6 1092.2 1116.4 29844.3 30004.8 30236.4 30343.7 30384.2 1093.1 1094.3 1116.8 1141.6 1196.3 16071.5 16275.3 16412.0 16535.4 16584.8 583062.0 587644.0 590137.0 590273.0 591945.0 59921.4 60132.0 60132.7 60269.0 60422.7 1290.3 1356.9 1370.2 1371.3 1375.5 30126.0 30843.8 30964.5 32189.5 32239.4 52462.7 52650.0 52778.0 52821.7 52886.7 463398.0 464021.0 464217.0 466007.0 470184.0 24986.3 27160.7 28651.4 28906.4 28989.6 43109.6 47916.3 48019.0 48119.5 48310.3 40620.6 40903.8 41943.0 42257.8 42511.0 40725.8 40750.8 41143.8 42155.8 42302.4 39753.4 40814.6 42126.8 42186.8 44317.6 34164.7 37817.8 38060.4 38152.0 38599.2 26702.9 27110.5 27344.3 27475.9 27933.2 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#2] jquery.html Cycles:180 Average:31450.82 Median:2777.52 stddev:94455.74 (3400.7%) stddev-sans-first:94691.89 20:29:36 INFO - PROCESS | 9609 | Values: 376.7 387.2 394.3 400.8 415.9 14171.5 17502.8 19472.6 19776.5 19948.9 17863.6 17880.4 17904.5 18055.8 18100.2 4279.7 5624.4 5811.3 5815.6 5817.0 5162.4 6534.7 6622.5 6693.1 6693.3 6350.5 6432.2 6478.3 6650.4 6664.3 6298.4 6517.4 6541.8 6552.5 6553.4 5671.7 5713.3 5740.1 5755.5 5758.3 23286.9 23644.2 23803.4 23825.6 24015.2 2428.0 2528.6 2577.0 2978.0 3055.3 14338.3 14833.7 14916.1 15515.1 15599.5 1774.8 1841.8 1872.2 1901.7 1942.5 74308.6 75804.0 81894.6 87227.6 88465.6 10399.4 10493.5 10912.2 10955.0 11060.6 15545.4 15594.2 15605.8 15613.8 15637.1 7320.7 7442.4 7571.4 7627.6 7652.1 7037.9 7138.8 7278.9 7293.1 7295.2 4379.0 4493.9 4565.8 4708.9 4721.3 1821.9 1918.6 1953.8 1971.0 2029.8 834.6 926.7 954.6 968.7 975.1 18292.9 19373.4 19594.7 20437.3 20565.4 984.3 995.5 997.3 1020.2 1027.5 10497.6 11142.7 11215.4 11282.9 11338.4 567861.0 568841.0 577402.0 581530.0 582908.0 59773.7 63532.0 97351.0 98408.0 103730.0 1011.2 1045.9 1084.4 1108.7 1118.3 17228.2 17341.6 17933.7 17991.9 18256.6 40484.4 42029.4 45107.3 45736.8 46191.8 55865.0 56556.7 59075.0 62704.7 64095.0 8126.0 8185.0 8200.5 8210.5 8445.2 12278.5 12768.7 12783.7 13065.7 13157.3 11660.0 11865.3 11912.8 12043.0 12453.6 11908.6 11950.3 11978.8 12328.4 12468.9 11809.6 11841.5 11957.6 12089.0 12226.9 8177.3 8391.7 8547.0 8554.5 8605.5 11664.8 11670.8 11717.6 11738.6 11834.9 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#3] mootools.html Cycles:180 Average:5978.02 Median:4794.94 stddev:3369.88 (70.3%) stddev-sans-first:3361.61 20:29:36 INFO - PROCESS | 9609 | Values: 1379.6 1482.1 1531.9 1643.6 1770.1 8558.9 8825.6 8847.7 9000.7 9005.7 8952.4 9040.0 9040.2 9040.7 9045.4 2363.1 2396.4 2398.7 2401.0 2402.0 2366.3 2400.3 2420.5 2421.4 2422.1 2365.8 2370.9 2388.7 2444.0 2449.9 2314.8 2319.7 2325.5 2326.0 2385.7 2346.3 2376.2 2381.3 2383.0 2383.5 8847.8 9001.4 9060.2 9062.8 9068.0 5199.7 5350.7 5404.2 5412.3 5447.3 3482.7 3507.3 3551.4 3553.3 3570.0 1129.8 1134.7 1138.6 1169.7 1171.2 12447.6 12546.3 12639.3 12668.2 12673.7 4720.0 4829.6 4896.6 4982.2 4991.0 10745.3 10750.8 10750.8 10762.9 10767.3 5454.2 5455.9 5457.0 5457.3 5461.1 4390.8 4760.3 4879.3 4919.4 4996.0 4079.3 4099.8 4208.6 4249.1 4275.0 1290.7 1340.6 1351.1 1363.1 1366.6 1003.1 1004.5 1024.9 1030.3 1048.8 6072.9 6101.8 6146.5 6278.3 6295.0 980.3 984.5 991.2 1011.5 1055.5 4100.1 4215.2 4269.6 4373.6 4457.6 10968.6 11199.3 11260.7 11306.7 11392.7 11351.4 11366.8 11367.6 11369.8 11373.4 8016.2 8202.5 8210.2 8425.1 8433.4 6238.2 6391.5 6479.8 6481.9 6537.4 9829.5 9865.1 9899.6 9989.9 10004.2 10169.3 10257.3 10305.0 10487.8 10592.2 7337.9 7987.6 8072.1 8209.3 8248.2 8901.8 8933.6 8945.8 8958.0 8963.3 7816.0 7886.5 8027.3 8094.4 8160.2 7716.7 7852.9 7895.7 7897.1 7934.0 7118.6 7208.1 7209.6 7210.3 7220.5 5348.2 5440.2 5452.5 5475.8 5618.1 5298.7 5299.1 5301.2 5349.5 5429.5 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#4] prototype.html Cycles:180 Average:4607.03 Median:5261.83 stddev:1355.81 (25.8%) stddev-sans-first:1320.65 20:29:36 INFO - PROCESS | 9609 | Values: 307.9 316.6 324.6 324.8 327.0 5191.9 5242.1 5246.0 5264.1 5278.3 4924.5 5021.9 5026.7 5036.6 5205.9 3949.2 4003.8 4075.2 4098.8 4117.3 4098.0 4114.5 4140.3 4151.3 4162.5 3867.8 4022.0 4035.7 4137.4 4152.5 4028.6 4043.7 4062.8 4069.4 4076.6 3579.9 3590.4 3592.1 3596.6 3599.4 4895.7 5180.7 5187.8 5190.3 5206.6 4610.0 4619.6 4624.7 4631.9 4663.1 5430.0 5430.8 5434.9 5443.7 5482.4 3836.3 3890.1 3893.5 3916.7 3930.5 5585.0 5590.7 5666.7 5679.9 5709.5 3953.5 3958.8 3962.7 3984.7 3991.1 4042.2 4043.8 4059.1 4060.3 4079.2 4510.2 4599.6 4622.1 4626.9 4677.2 5449.9 5452.0 5457.7 5467.9 5469.9 1323.6 1386.4 1394.2 1402.4 1403.7 918.6 931.0 947.2 953.5 953.7 5199.5 5227.8 5238.0 5259.6 5328.0 5574.6 5583.9 5592.4 5592.5 5602.8 5136.2 5365.2 5371.9 5380.0 5404.5 2969.2 2995.5 2997.2 2999.1 3015.2 5681.5 5767.7 5857.7 5866.8 5873.3 5681.4 5686.2 5697.0 5702.4 5727.9 5731.3 5764.4 5823.4 5845.2 5848.4 5358.0 5586.2 5600.9 5601.0 5608.5 5524.3 5546.2 5548.8 5587.8 5624.5 5565.9 5793.2 5793.2 5794.0 5853.7 3971.5 3974.6 3986.8 4005.9 4022.3 5649.2 5650.8 5663.3 5673.4 5683.5 5242.8 5472.2 5481.9 5550.4 5558.8 5448.6 5453.4 5471.1 5474.5 5511.2 5193.9 5239.3 5363.5 5419.6 5470.2 5461.2 5489.0 5512.4 5518.8 5530.0 5392.5 5394.6 5397.0 5458.4 5485.8 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - PROCESS | 9609 | [#5] yui.html Cycles:180 Average:20917.83 Median:4509.11 stddev:30568.75 (677.9%) stddev-sans-first:30616.96 20:29:36 INFO - PROCESS | 9609 | Values: 740.1 743.8 762.3 767.4 768.2 14802.9 15046.8 15151.3 15234.8 16208.4 14931.6 15404.8 15410.2 15419.9 15468.7 817.7 834.6 835.8 836.4 836.5 677.8 812.7 832.3 833.4 842.7 880.2 881.2 883.2 883.5 884.4 867.6 875.8 877.6 879.2 879.3 513.7 619.1 632.3 632.6 638.3 15175.5 15194.1 15198.8 15207.4 15225.0 14146.2 14401.9 14672.7 14724.1 15063.0 13496.0 13642.7 13727.8 13817.9 14320.4 4453.6 4464.5 4490.9 4527.3 4560.6 80381.0 80752.2 80787.6 81042.0 81120.0 11081.5 11130.7 11544.4 11913.1 12025.5 21137.0 21561.7 21624.5 21641.5 21656.6 8507.5 8751.5 8858.7 8890.6 8910.1 4734.4 4829.3 4896.4 5035.7 5054.2 3302.4 3376.7 3381.5 3382.3 3384.7 582.6 594.6 599.9 607.3 616.4 665.5 700.5 703.1 713.3 738.9 8978.5 9358.2 9699.0 9743.9 9779.3 625.3 637.9 661.3 688.9 716.5 4265.0 4283.9 4318.7 4352.8 4450.9 112204.0 112510.0 114619.0 117723.0 119221.0 100742.0 102724.5 103325.3 104480.0 107102.0 81103.0 83102.6 83360.0 86109.0 87194.6 8560.8 8712.4 8719.7 8835.5 8971.9 51163.2 51670.0 52244.5 52460.0 53428.5 69122.9 74664.0 78180.0 78299.2 80173.6 12112.6 12231.6 12250.4 13052.2 13087.9 12881.7 12950.7 13037.9 13433.3 13662.6 11964.9 12200.1 12233.9 12271.4 12711.7 12099.1 12231.3 12232.9 12238.0 12338.6 11906.4 12078.6 12125.6 12308.5 12382.2 9718.8 10146.9 10175.3 10186.9 10286.6 9752.5 10154.9 10296.0 10297.6 10306.1 20:29:36 INFO - PROCESS | 9609 | -------- Summary: end -------- 20:29:36 INFO - PROCESS | 9609 | 20:29:36 INFO - TEST-INFO | 9609: exit 0 20:29:36 INFO - TEST-OK | dromaeo_css | took 1114539ms 20:29:36 INFO - TEST-START | kraken 20:29:36 INFO - operating with platform_type : linux_ 20:29:36 INFO - Initialising browser for kraken test... 20:29:36 INFO - TEST-INFO | started process 9803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiyUFlP/profile http://localhost:41165/getInfo.html) 20:29:40 INFO - PROCESS | 9803 | JavaScript error: , line 0: uncaught exception: undefined 20:29:41 INFO - PROCESS | 9803 | __metrics Screen width/height:1600/1200 20:29:41 INFO - PROCESS | 9803 | colorDepth:24 20:29:41 INFO - PROCESS | 9803 | Browser inner width/height: 1024/697 20:29:41 INFO - PROCESS | 9803 | __metrics 20:29:41 INFO - PROCESS | 9803 | 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" 20:29:41 INFO - PROCESS | 9803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:42 INFO - TEST-INFO | 9803: exit 0 20:29:42 INFO - Browser initialized. 20:29:42 INFO - Running cycle 1/1 for kraken test... 20:29:42 INFO - TEST-INFO | started process 9885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiyUFlP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:54 INFO - PROCESS | 9885 | RSS: Main: 158056448 20:29:54 INFO - PROCESS | 9885 | 20:29:57 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:58 INFO - PROCESS | 9885 | RSS: Main: 213905408 20:29:58 INFO - PROCESS | 9885 | 20:30:00 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-dft) 20:30:01 INFO - PROCESS | 9885 | RSS: Main: 193294336 20:30:01 INFO - PROCESS | 9885 | 20:30:04 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-fft) 20:30:04 INFO - PROCESS | 9885 | RSS: Main: 270557184 20:30:04 INFO - PROCESS | 9885 | 20:30:06 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-oscillator) 20:30:07 INFO - PROCESS | 9885 | RSS: Main: 181100544 20:30:07 INFO - PROCESS | 9885 | 20:30:09 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:30:10 INFO - PROCESS | 9885 | RSS: Main: 185475072 20:30:10 INFO - PROCESS | 9885 | 20:30:13 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-darkroom) 20:30:13 INFO - PROCESS | 9885 | RSS: Main: 221683712 20:30:13 INFO - PROCESS | 9885 | 20:30:17 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-desaturate) 20:30:17 INFO - PROCESS | 9885 | RSS: Main: 220909568 20:30:17 INFO - PROCESS | 9885 | 20:30:20 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41165/tests/kraken/driver.html?testName=json-parse-financial) 20:30:21 INFO - PROCESS | 9885 | RSS: Main: 220971008 20:30:21 INFO - PROCESS | 9885 | 20:30:22 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:30:23 INFO - PROCESS | 9885 | RSS: Main: 185667584 20:30:23 INFO - PROCESS | 9885 | 20:30:25 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:25 INFO - PROCESS | 9885 | RSS: Main: 191582208 20:30:25 INFO - PROCESS | 9885 | 20:30:27 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:30:28 INFO - PROCESS | 9885 | RSS: Main: 195809280 20:30:28 INFO - PROCESS | 9885 | 20:30:30 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:31 INFO - PROCESS | 9885 | RSS: Main: 188493824 20:30:31 INFO - PROCESS | 9885 | 20:30:34 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:34 INFO - PROCESS | 9885 | RSS: Main: 193830912 20:30:34 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41165/tests/kraken/driver.html?testName=ai-astar) 20:30:36 INFO - PROCESS | 9885 | RSS: Main: 244662272 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | __start_tp_report 20:30:36 INFO - PROCESS | 9885 | _x_x_mozilla_page_load 20:30:36 INFO - PROCESS | 9885 | _x_x_mozilla_page_load_details 20:30:36 INFO - PROCESS | 9885 | |i|pagename|runs| 20:30:36 INFO - PROCESS | 9885 | |0;ai-astar;103;113;112;114;113;111;111;110;113;111 20:30:36 INFO - PROCESS | 9885 | |1;audio-beat-detection;141;122;123;177;123;118;144;122;148;120 20:30:36 INFO - PROCESS | 9885 | |2;audio-dft;162;162;161;161;161;161;161;161;161;160 20:30:36 INFO - PROCESS | 9885 | |3;audio-fft;73;74;74;132;77;78;75;74;114;75 20:30:36 INFO - PROCESS | 9885 | |4;audio-oscillator;84;83;118;84;84;83;119;84;84;139 20:30:36 INFO - PROCESS | 9885 | |5;imaging-gaussian-blur;117;116;116;117;116;117;116;117;117;116 20:30:36 INFO - PROCESS | 9885 | |6;imaging-darkroom;149;148;153;153;151;154;152;152;150;153 20:30:36 INFO - PROCESS | 9885 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;95;95 20:30:36 INFO - PROCESS | 9885 | |8;json-parse-financial;53;52;51;51;51;52;52;51;51;51 20:30:36 INFO - PROCESS | 9885 | |9;json-stringify-tinderbox;63;63;63;62;63;63;63;63;63;62 20:30:36 INFO - PROCESS | 9885 | |10;stanford-crypto-aes;76;78;79;84;76;84;76;81;79;81 20:30:36 INFO - PROCESS | 9885 | |11;stanford-crypto-ccm;129;126;126;122;135;128;123;121;167;125 20:30:36 INFO - PROCESS | 9885 | |12;stanford-crypto-pbkdf2;159;160;159;159;160;160;158;155;159;158 20:30:36 INFO - PROCESS | 9885 | |13;stanford-crypto-sha256-iterative;64;63;64;62;63;62;63;62;62;61 20:30:36 INFO - PROCESS | 9885 | __end_tp_report 20:30:36 INFO - PROCESS | 9885 | __start_cc_report 20:30:36 INFO - PROCESS | 9885 | _x_x_mozilla_cycle_collect,1674 20:30:36 INFO - PROCESS | 9885 | __end_cc_report 20:30:36 INFO - PROCESS | 9885 | __startTimestamp1469849436761__endTimestamp 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | ------- Summary: start ------- 20:30:36 INFO - PROCESS | 9885 | Number of tests: 14 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.11 (2.8%) stddev-sans-first:1.32 20:30:36 INFO - PROCESS | 9885 | Values: 103.0 113.0 112.0 114.0 113.0 111.0 111.0 110.0 113.0 111.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:132.00 stddev:18.78 (14.2%) stddev-sans-first:19.74 20:30:36 INFO - PROCESS | 9885 | Values: 141.0 122.0 123.0 177.0 123.0 118.0 144.0 122.0 148.0 120.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 20:30:36 INFO - PROCESS | 9885 | Values: 162.0 162.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 160.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.50 stddev:20.73 (27.8%) stddev-sans-first:21.56 20:30:36 INFO - PROCESS | 9885 | Values: 73.0 74.0 74.0 132.0 77.0 78.0 75.0 74.0 114.0 75.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:20.87 (24.8%) stddev-sans-first:21.66 20:30:36 INFO - PROCESS | 9885 | Values: 84.0 83.0 118.0 84.0 84.0 83.0 119.0 84.0 84.0 139.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:30:36 INFO - PROCESS | 9885 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.50 stddev:1.96 (1.3%) stddev-sans-first:1.86 20:30:36 INFO - PROCESS | 9885 | Values: 149.0 148.0 153.0 153.0 151.0 154.0 152.0 152.0 150.0 153.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:30:36 INFO - PROCESS | 9885 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:0.71 (1.4%) stddev-sans-first:0.50 20:30:36 INFO - PROCESS | 9885 | Values: 53.0 52.0 51.0 51.0 51.0 52.0 52.0 51.0 51.0 51.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 20:30:36 INFO - PROCESS | 9885 | Values: 63.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 62.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:3.06 (3.8%) stddev-sans-first:2.99 20:30:36 INFO - PROCESS | 9885 | Values: 76.0 78.0 79.0 84.0 76.0 84.0 76.0 81.0 79.0 81.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.00 stddev:13.54 (10.7%) stddev-sans-first:14.35 20:30:36 INFO - PROCESS | 9885 | Values: 129.0 126.0 126.0 122.0 135.0 128.0 123.0 121.0 167.0 125.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 20:30:36 INFO - PROCESS | 9885 | Values: 159.0 160.0 159.0 159.0 160.0 160.0 158.0 155.0 159.0 158.0 20:30:36 INFO - PROCESS | 9885 | 20:30:36 INFO - PROCESS | 9885 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 20:30:36 INFO - PROCESS | 9885 | Values: 64.0 63.0 64.0 62.0 63.0 62.0 63.0 62.0 62.0 61.0 20:30:36 INFO - PROCESS | 9885 | -------- Summary: end -------- 20:30:36 INFO - PROCESS | 9885 | 20:30:37 INFO - TEST-INFO | 9885: exit 0 20:30:37 INFO - TEST-OK | kraken | took 60953ms 20:30:37 INFO - SUITE-END | took 1175s 20:30:37 INFO - Completed test suite (00:19:35) 20:30:37 INFO - javascript benchmark 20:30:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.357954829487, 3069.769767267455, 3083.1058992892063, 3099.845007749612, 3116.11190810619, 5212.635115541904, 5264.947350526493, 5357.8748462822805, 5432.239486471892, 5456.945430545688, 5348.411674715788, 5360.91958620621, 5399.244105825188, 5402.108652072413, 5460.754266058027, 4831.299461578078, 4875.756212189394, 4902.460729319772, 4920.3111564381015, 5031.597472202233, 4937.679050861682, 4959.900801983958, 4983.22759972203, 4995.850124496253, 5000.574951129159, 4790.520947905182, 4797.9520204797855, 4857.0, 4858.125537403266, 4939.506049395068, 4885.584725298354, 4897.363342765453, 4900.191468407708, 4907.411110666707, 4965.773868746758, 4910.607151427877, 4933.309336692866, 4941.777620007072, 4948.331975183341, 4950.0, 5234.110201265794, 5295.073362161606, 5392.110301800199, 5406.972965135188, 5454.672719636795, 5713.942860571424, 5729.28383952006, 5775.16260142277, 5784.768609255625, 5790.7683692652245, 5742.138679198112, 5768.682722450264, 5819.912701309484, 5824.417558244184, 5829.067349224146, 5149.253358263069, 5288.312519372457, 5315.830517286191, 5342.732863356817, 5436.3476382834315, 5967.283925928917, 5973.880522389528, 5974.3428222895445, 5977.402259774075, 5980.760769569256, 5714.857128571819, 5719.256496655408, 5724.0, 5725.77096916127, 5729.398413166641, 5560.582956278296, 5583.637063590853, 5592.440755924375, 5599.7480113394995, 5706.572007099484, 5632.295963004624, 5633.0987042073075, 5634.0, 5637.548996080303, 5665.688387138664, 5635.605507614509, 5645.379008309083, 5708.971455142698, 5710.086386178192, 5712.971435142797, 4296.0548679290505, 4332.67504937131, 4345.369921361448, 4362.716423432466, 4387.0, 3900.7659540427667, 3907.765534067908, 3910.7458015228917, 3932.8230229639735, 3951.091249012743, 5436.266104075979, 5440.891182176334, 5442.8911421771345, 5449.754761035763, 5460.34475862899, 5576.302962129734, 5686.630369026, 5717.571182161355, 5727.570432217601, 5810.099434587646, 5453.509184173444, 5455.18172274162, 5457.181422786534, 5459.39946605881, 5482.588805839578, 4890.755462226874, 4897.730624815669, 4898.0, 4905.337779399807, 4941.555260026615, 5785.739641716049, 5873.618214816023, 5919.644821310735, 5920.644761314249, 5973.641581505037, 5736.483716465538, 5738.397468265772, 5741.081426971665, 5741.942580574308, 5780.075187969905, 5928.762849485972, 5939.940600594112, 5940.287165540163, 5944.019236826049, 5945.137954996588, 5429.0, 5558.805441809517, 5564.972175139098, 5584.888302234014, 5614.915776263278, 5713.571482138939, 5751.712414379181, 5756.568257380797, 5764.654120752768, 5801.709914504342, 5581.079121944996, 5583.581231407579, 5590.273264475755, 5593.0771422716425, 5596.468335508121, 5462.6995515247045, 5562.249096371938, 5579.246801681721, 5589.077802162597, 5615.691136987505, 5586.301712285965, 5594.356648985256, 5594.440555944373, 5594.552435805044, 5635.633683810539, 5645.68948707825, 5680.573956953162, 5737.770489180553, 5742.339630942495, 5746.885062298814, 5432.103702889137, 5455.481729235717, 5459.863503412446, 5549.472800084147, 5552.972235138798], "value": 5288.668365911476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6095377051147, 621.8103478439077, 629.1286568103176, 632.197109670718, 647.6308504152632, 43323.13353732923, 44494.777526112324, 44523.0, 44602.33096503551, 48718.26922596164, 44812.3278150828, 45254.54745452553, 45257.54742452574, 45342.319865201964, 45385.0, 8953.507557084342, 9070.138336858021, 9128.771780705469, 9137.0, 9142.222911052535, 8886.955565222164, 8889.511076890769, 8969.686060987866, 8977.0, 8980.281577473786, 8905.0, 8949.507777072258, 8949.686760963368, 9029.59366828491, 9047.773805654846, 8965.865512017324, 8995.5052472114, 9024.909750902472, 9032.051634578405, 9037.186653201177, 8868.15752503511, 8918.866217006751, 8927.330450216195, 8937.50843703596, 8943.284537237005, 43017.56982430167, 43330.0, 43411.0, 43447.56552434467, 43480.13039739219, 3388.695017448417, 3420.0936751760805, 3427.160345715291, 3859.4017927221325, 4046.210988857174, 33228.50157247619, 33537.496937545955, 33700.0, 33942.83028584866, 34365.656343436494, 4330.328799036154, 4414.161309351213, 4414.889627759299, 4517.638588912879, 4519.706219095749, 355928.0, 362156.0, 363358.0, 482728.5863570695, 483592.0, 62716.37283627196, 62917.685411572646, 63153.36846631567, 63260.367396326365, 63263.36736632667, 56689.149662755095, 63570.36429635737, 65183.67408162929, 66347.33652663411, 66823.99056056653, 14645.48740794067, 14655.267236638125, 14710.632234194016, 14827.555173344817, 14840.40638374453, 10696.304740191863, 10749.140068794477, 10768.892311076788, 10777.083947864363, 10889.83665245022, 17110.657786844193, 19061.0, 19300.71048934267, 19470.750151540713, 20065.29771457992, 7110.329792569851, 7264.367816091954, 7297.817554561178, 7399.0, 7463.104427468738, 954.9713508594754, 1061.1881910338598, 1071.5767271927546, 1092.2136062035322, 1116.3859877067744, 29844.253893652833, 30004.84997574998, 30236.395272094436, 30343.69656303453, 30384.240393990327, 1093.147345070846, 1094.2504384496644, 1116.821308590638, 1141.6232643227715, 1196.342011893455, 16071.517854464384, 16275.348986040426, 16412.0, 16535.421260255833, 16584.83415165857, 583062.0, 587644.0, 590137.0, 590273.0, 591945.0, 59921.40078599245, 60132.0, 60132.699336503916, 60269.0, 60422.69788651029, 1290.251654040654, 1356.8982326325565, 1370.1778932640536, 1371.3143428285857, 1375.5116933488669, 30126.0, 30843.845780770953, 30964.535531966587, 32189.517157242193, 32239.389946900614, 52462.737686311324, 52650.0, 52778.0, 52821.7358913203, 52886.73556632346, 463398.0, 464021.0, 464217.0, 466007.0, 470184.0, 24986.250412487654, 27160.72839271582, 28651.426971460038, 28906.42187156203, 28989.56515652309, 43109.56890431181, 47916.281255780494, 48019.0, 48119.518804812906, 48310.27534587054, 40620.593794062865, 40903.795481022404, 41943.0, 42257.78871105625, 42511.0, 40725.796371017954, 40750.79624601858, 41143.7942810296, 42155.789221054925, 42302.36546451744, 39753.40369894396, 40814.59185408108, 42126.78936605297, 42186.78906605447, 44317.556824432635, 34164.658353417144, 37817.81091094527, 38060.42909356417, 38152.0, 38599.228015440094, 26702.866485667448, 27110.457790844466, 27344.31639208956, 27475.86262068677, 27933.16200513988], "value": 20374.286874413778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7438142063396, 387.1675896821831, 394.27847039916946, 400.84968136948646, 415.93760935859615, 14171.503997360094, 17502.81214848144, 19472.610547789034, 19776.505587360323, 19948.90025549872, 17863.553411164696, 17880.37418690346, 17904.462866114005, 18055.81944180558, 18100.185491652875, 4279.700420970534, 5624.409437009127, 5811.331696854873, 5815.5638327125425, 5817.040188368936, 5162.354705661793, 6534.705938232767, 6622.53642245043, 6693.062971184038, 6693.297203793604, 6350.460210882081, 6432.195975503062, 6478.255000674935, 6650.434713049397, 6664.266930637626, 6298.3701629837105, 6517.446017088553, 6541.771038013647, 6552.525681721599, 6553.410193082598, 5671.6597004179885, 5713.257276554063, 5740.1102829061565, 5755.539556835443, 5758.2514273144225, 23286.883565582233, 23644.172453964027, 23803.40491487727, 23825.61743825621, 24015.15946941866, 2428.0, 2528.6080657497932, 2577.0336123953516, 2978.0, 3055.3125546752026, 14338.283085845665, 14833.70332593353, 14916.105033698013, 15515.146666933315, 15599.532014039596, 1774.8047714751367, 1841.815818418161, 1872.2136702584946, 1901.657701613709, 1942.4852414110271, 74308.62845685791, 75804.0, 81894.59052704758, 87227.56386218092, 88465.55767221123, 10399.376037437778, 10493.475326233658, 10912.181586381053, 10955.0, 11060.612878549373, 15545.37818487248, 15594.220288985505, 15605.765913511306, 15613.84386156124, 15637.13995730223, 7320.67056982437, 7442.359462385899, 7571.3564347031115, 7627.580483073484, 7652.120006199359, 7037.92962070383, 7138.785836424916, 7278.890816637755, 7293.0519032525435, 7295.161056478467, 4378.978105109454, 4493.887652808706, 4565.794539245742, 4708.858734237979, 4721.3390125382475, 1821.8815776974454, 1918.5587314917648, 1953.765548134233, 1970.9802901970797, 2029.84776141787, 834.586879494642, 926.7358802741186, 954.6420092465326, 968.7432830299977, 975.0980343182528, 18292.908535457504, 19373.4187974361, 19594.70607940882, 20437.284695035603, 20565.38303850887, 984.2962281968427, 995.4674249276602, 997.3118548201718, 1020.2195320579763, 1027.5016616940777, 10497.62974361526, 11142.721431964266, 11215.383153926612, 11282.94358528202, 11338.376389298503, 567861.0, 568841.0, 577402.0, 581530.0, 582908.0, 59773.701131494934, 63532.0, 97351.0, 98408.0, 103730.0, 1011.206203130539, 1045.8849526552226, 1084.38732116354, 1108.706192858893, 1118.2842980492492, 17228.224729887435, 17341.56646083858, 17933.730994035363, 17991.910040449715, 18256.634867302313, 40484.3927341096, 42029.36955945602, 45107.323390148515, 45736.771316143204, 46191.76904115458, 55865.0, 56556.71721641366, 59075.0, 62704.68647656732, 64095.0, 8126.0, 8185.0, 8200.466969646954, 8210.507369557607, 8445.1977062179, 12278.508859645513, 12768.74462510726, 12783.680407989874, 13065.738685226432, 13157.276349800853, 11660.0, 11865.347405892759, 11912.76174476523, 12042.976347010603, 12453.564125255572, 11908.583199587973, 11950.34273114987, 11978.76042479163, 12328.383580821102, 12468.942624466861, 11809.645710628694, 11841.467133979164, 11957.641270761891, 12089.0, 12226.938865305972, 8177.264046235868, 8391.706290279812, 8547.0, 8554.529500877512, 8605.483670979762, 11664.825027624423, 11670.824937625772, 11717.648470545897, 11738.647840564796, 11834.940825295818], "value": 9421.93225723712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.5516457151416, 1482.058892603197, 1531.9080855148693, 1643.55623981525, 1770.0530216334255, 8558.871616925744, 8825.602847871845, 8847.734567962956, 9000.729978100651, 9005.684801031965, 8952.418092823962, 9039.954800226005, 9040.186383225508, 9040.683576074838, 9045.3668243223, 2363.1256435118985, 2396.4488167721347, 2398.6761787158684, 2400.9639855402183, 2402.027178992511, 2366.325597204797, 2400.339906525711, 2420.491696743677, 2421.406755344943, 2422.0917156066475, 2365.8462199957034, 2370.881455927197, 2388.653645221442, 2443.951120977579, 2449.865257410842, 2314.7685231476885, 2319.675245465636, 2325.476767727256, 2325.988370058147, 2385.7017872765905, 2346.3195673254736, 2376.192094687797, 2381.30942026812, 2383.0467812874817, 2383.4518060846103, 8847.823043539158, 9001.369904106716, 9060.184583387527, 9062.77343066422, 9067.954660226656, 5199.66202196856, 5350.678959262418, 5404.243405923174, 5412.296401467784, 5447.319085114361, 3482.703970162539, 3507.298540291926, 3551.4140166872435, 3553.34263161316, 3570.0003998880356, 1129.785340785248, 1134.7163209197702, 1138.59579849154, 1169.7309618787642, 1171.1567671276666, 12447.626571202787, 12546.309952952584, 12639.304838233893, 12668.17656852311, 12673.683157921034, 4719.95280047202, 4829.613630909519, 4896.608271338285, 4982.153033984231, 4991.0, 10745.301555398873, 10750.78498430027, 10750.78498430027, 10762.892371076188, 10767.300125491818, 5454.154606036071, 5455.890882182334, 5457.0, 5457.2905522282645, 5461.0716178249795, 4390.846320378771, 4760.262159365235, 4879.341288926021, 4919.385076865392, 4995.9500404996215, 4079.347304431277, 4099.774512401847, 4208.558101399371, 4249.086446414036, 4274.957250427518, 1290.677330667333, 1340.5710172744823, 1351.108268542757, 1363.1139759156626, 1366.590022993098, 1003.1373019203479, 1004.5278719002057, 1024.8770147582338, 1030.299396410433, 1048.7849990751877, 6072.876517844213, 6101.7559297627595, 6146.508279337642, 6278.340774218641, 6294.968525157345, 980.2550061952967, 984.4683870709737, 991.1971303244395, 1011.5346940407347, 1055.5408397347178, 4100.1184745279315, 4215.220184265921, 4269.573042695705, 4373.606375426227, 4457.554244575516, 10968.616098436676, 11199.272047316897, 11260.662180134608, 11306.660800175843, 11392.715182120513, 11351.375674337825, 11366.772664546828, 11367.602133925273, 11369.829452558219, 11373.431328433546, 8016.158303378178, 8202.466839655403, 8210.178982101743, 8425.073241943504, 8433.367497437717, 6238.157848690369, 6391.48868090561, 6479.773207937699, 6481.935180648133, 6537.444317232898, 9829.459379734184, 9865.112139907444, 9899.604015839574, 9989.900100999188, 10004.199664026715, 10169.288149829441, 10257.281990260908, 10305.0, 10487.842682359618, 10592.205584581341, 7337.926620733724, 7987.600619968862, 8072.143407016301, 8209.302209312036, 8248.216419440143, 8901.777455563404, 8933.553322333988, 8945.821083578423, 8957.955210224169, 8963.282937365126, 7816.0, 7886.48737832062, 8027.277545020743, 8094.352451803959, 8160.183981601793, 7716.691332346643, 7852.882206766789, 7895.68417263303, 7897.05235371759, 7933.968584084032, 7118.572885626879, 7208.098987626547, 7209.603471808891, 7210.2789721027475, 7220.494565380373, 5348.1977703343255, 5440.156775699773, 5452.509274165344, 5475.780968761205, 5618.129189975561, 5298.708571028476, 5299.099153143898, 5301.1783173608155, 5349.518543331119, 5429.511343979061], "value": 4795.7558385362345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.87223302329534, 316.5568204513681, 324.56832412890856, 324.8424514110656, 326.9901902942911, 5191.948080519193, 5242.08263553878, 5246.0, 5264.1051021326375, 5278.261043453915, 4924.458309585952, 5021.874453138665, 5026.723530205837, 5036.622253331006, 5205.947940520594, 3949.2299001694682, 4003.819828107742, 4075.1849630073957, 4098.8360465581345, 4117.279476091687, 4097.9510244877565, 4114.485689288839, 4140.296149654551, 4151.252774500589, 4162.521310049337, 3867.7679339239594, 4021.9798901005456, 4035.6973227007943, 4137.40007698885, 4152.501699796028, 4028.6172813582807, 4043.65628921542, 4062.8217816833085, 4069.4302797608357, 4076.5515793262716, 3579.8926032219074, 3590.425531914881, 3592.1019745063736, 3596.5684117906017, 3599.3881040223223, 4895.723488577828, 5180.6891586504935, 5187.792488300463, 5190.273361729361, 5206.635535512516, 4609.976950115228, 4619.607333376667, 4624.676272660915, 4631.907361852778, 4663.090697314025, 5430.0, 5430.755615997289, 5434.945650543484, 5443.673379597237, 5482.396936337, 3836.290286297044, 3890.144168282973, 3893.4549163116903, 3916.667083297923, 3930.5479869815053, 5584.972075139598, 5590.664560126364, 5666.744996475169, 5679.914801277984, 5709.457601527848, 3953.545342285674, 3958.802059897051, 3962.663173630216, 3984.6812255019527, 3991.1219531702977, 4042.171354872244, 4043.7775922324554, 4059.127287633173, 4060.289449346412, 4079.224947260011, 4510.188166130128, 4599.632029437637, 4622.128038144557, 4626.907461850744, 4677.18149323867, 5449.918251226235, 5451.972740136353, 5457.727113644302, 5467.917981230285, 5469.945300546943, 1323.5963031275553, 1386.383059538516, 1394.2401391241797, 1402.3689339797131, 1403.6771542545068, 918.6004088221645, 930.9767255818523, 947.1759569174862, 953.4612943686794, 953.6948176583427, 5199.454057324002, 5227.817026404057, 5237.973810130925, 5259.552938000236, 5327.9733601331745, 5574.554035677136, 5583.944160558342, 5592.412796656293, 5592.496675299242, 5602.803901863415, 5136.178211486219, 5365.22204280385, 5371.865703357369, 5379.973100134553, 5404.540614047772, 2969.198316454545, 2995.5207166853197, 2997.2057404787747, 2999.145243605562, 3015.2311160653894, 5681.488666020078, 5767.682777447197, 5857.736401861926, 5866.765329386777, 5873.2658417697785, 5681.4034526374135, 5686.232358631614, 5696.971515142398, 5702.429757024347, 5727.885442291131, 5731.283589551306, 5764.365919748824, 5823.359430462561, 5845.181674565564, 5848.356680765112, 5358.0, 5586.217929489793, 5600.85997850057, 5600.971995139998, 5608.495235428831, 5524.309461317335, 5546.168074788652, 5548.834744703496, 5587.776488940397, 5624.465675760796, 5565.916511252415, 5793.159991801081, 5793.188953546422, 5794.0, 5853.736581853742, 3971.5035620547433, 3974.5627980922654, 3986.760794352232, 4005.859794907164, 4022.316206244887, 5649.180868774087, 5650.773969041193, 5663.292088488939, 5673.439804053918, 5683.5453163747625, 5242.7902883885745, 5472.2338872557075, 5481.862953426196, 5550.417206193291, 5558.805441809517, 5448.618596698193, 5453.409630425516, 5471.124620060771, 5474.534664553557, 5511.200875873056, 5193.883315087274, 5239.318888544465, 5363.517283444508, 5419.593530485308, 5470.234167216513, 5461.208124821958, 5489.0, 5512.448755124456, 5518.841043380935, 5529.972350138223, 5392.487713667196, 5394.595405344537, 5396.9730151348995, 5458.426865179099, 5485.778259804785], "value": 4172.7619708495195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.1377395334432, 743.788020414182, 762.2910693055456, 767.4474378447519, 768.243280368837, 14802.851971480282, 15046.825601972432, 15151.318190681419, 15234.771478427818, 16208.432704855333, 14931.626709332271, 15404.768928466083, 15410.152441615735, 15419.922900385482, 15468.690626187497, 817.7138001699402, 834.5576844272546, 835.8119423129808, 836.3560058754755, 836.477201748907, 677.7661706711177, 812.7358608452276, 832.3382910586068, 833.4041160570191, 842.7008412013708, 880.2034159086037, 881.2025117268882, 883.1565854608833, 883.4964070479829, 884.3765145572356, 867.5748883047293, 875.8335916175906, 877.6006916852848, 879.2262808728342, 879.278991227194, 513.7020528093734, 619.1424876545972, 632.2792017100509, 632.5824955529329, 638.3488841381765, 15175.544733658007, 15194.088354698642, 15198.772018419733, 15207.391704331814, 15225.0, 14146.151230926178, 14401.927990360085, 14672.70654586913, 14724.116553006746, 15063.0, 13496.0, 13642.727145457035, 13727.794083088762, 13817.861821381859, 14320.355583998746, 4453.599176074136, 4464.486584042812, 4490.943347322891, 4527.275635898273, 4560.612347950429, 80381.0, 80752.19247807506, 80787.59606201931, 81042.0, 81120.0, 11081.501332440059, 11130.666080017612, 11544.365059921785, 11913.10651701126, 12025.518979240733, 21137.048832802255, 21561.67657485139, 21624.459388515097, 21641.458963526038, 21656.56686866254, 8507.489550626982, 8751.474911505331, 8858.689945851864, 8890.555472226362, 8910.108989101167, 4734.431868175841, 4829.323894654751, 4896.387951506062, 5035.723035233097, 5054.21659642756, 3302.3725492156414, 3376.74674399421, 3381.5096810962273, 3382.2728113455723, 3384.6784555467193, 582.5747204540625, 594.6224147666263, 599.9370066142992, 607.325868286202, 616.3713012726994, 665.5208250059949, 700.5236439221277, 703.1070540413646, 713.3080911515822, 738.903942487484, 8978.506182159914, 9358.204552613104, 9698.951505242429, 9743.902560974442, 9779.308967445491, 625.2965413909352, 637.8947473666885, 661.3122352753179, 688.9311068893071, 716.4805516000962, 4265.0, 4283.850065247701, 4318.740875547414, 4352.804123814436, 4450.910981780346, 112204.0, 112510.0, 114619.0, 117723.0, 119221.0, 100742.0, 102724.48637756763, 103325.25060620334, 104480.0, 107102.0, 81103.0, 83102.58448707718, 83360.0, 86109.0, 87194.56402718072, 8560.785980350542, 8712.433691810013, 8719.73840784752, 8835.469871807712, 8971.910280897107, 51163.23255151101, 51670.0, 52244.47755522396, 52459.95080098453, 53428.46571534235, 69122.88946997498, 74664.0, 78180.0, 78299.21700783147, 80173.5991320063, 12112.636620901387, 12231.571894983634, 12250.387480625755, 13052.15161014569, 13087.934560327518, 12881.742365152457, 12950.740985180431, 13037.934810325887, 13433.261170635318, 13662.590122296348, 11964.940175299067, 12200.145989780985, 12233.877661223274, 12271.447784849524, 12711.682207944505, 12099.11882190417, 12231.327276999851, 12232.87767122353, 12238.0, 12338.568150114703, 11906.40467976615, 12078.637640870787, 12125.636230913087, 12308.50765969387, 12382.195157314745, 9718.75703107428, 10146.898531014594, 10175.338602991078, 10186.898131018892, 10286.639967601099, 9752.512374381395, 10154.898451015692, 10296.0, 10297.588096476056, 10306.072453479223], "value": 7475.737679462399, "unit": "score"}], "name": "dromaeo_css", "value": 7304.516848716633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 114.0, 113.0, 111.0, 111.0, 110.0, 113.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 122.0, 123.0, 177.0, 123.0, 118.0, 144.0, 122.0, 148.0, 120.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 132.0, 77.0, 78.0, 75.0, 74.0, 114.0, 75.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 84.0, 84.0, 83.0, 119.0, 84.0, 84.0, 139.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 153.0, 153.0, 151.0, 154.0, 152.0, 152.0, 150.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 51.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 79.0, 84.0, 76.0, 84.0, 76.0, 81.0, 79.0, 81.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 126.0, 122.0, 135.0, 128.0, 123.0, 121.0, 167.0, 125.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 159.0, 160.0, 160.0, 158.0, 155.0, 159.0, 158.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1494.8000000000002, "alertThreshold": 2.0}]} 20:30:38 INFO - Return code: 0 20:30:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:30:38 INFO - # TBPL SUCCESS # 20:30:38 INFO - Running post-action listener: _resource_record_post_action 20:30:38 INFO - [mozharness: 2016-07-30 03:30:38.072758Z] Finished run-tests step (success) 20:30:38 INFO - Running post-run listener: _resource_record_post_run 20:30:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 151552; Write bytes: 307752960; Read time: 60; Write time: 258508 20:30:38 INFO - TinderboxPrint: CPU usage
13.0% 20:30:38 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 60 20:30:38 INFO - TinderboxPrint: I/O write bytes / time
307,752,960 / 258,508 20:30:38 INFO - TinderboxPrint: CPU idle
8,285.1 (87.0%) 20:30:38 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 20:30:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:30:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13955072; Read time: 0; Write time: 1840 20:30:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 151552; Write bytes: 293797888; Read time: 60; Write time: 256668 20:30:38 INFO - Running post-run listener: _upload_blobber_files 20:30:38 INFO - Blob upload gear active. 20:30:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:30:38 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 20:30:38 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:30:38 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:30:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:39 INFO - (blobuploader) - INFO - Done attempting. 20:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:40 INFO - (blobuploader) - INFO - Done attempting. 20:30:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:30:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:43 INFO - (blobuploader) - INFO - Done attempting. 20:30:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:43 INFO - Return code: 0 20:30:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:30:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e7710df7439ee90b6c4796537a030121ea17587f8ca334421275c10fef920ba639ef26801bfdaed6a9ba728b015c353666466dc478dfd39a0fc4dcadcd45a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43a982fdf5ef7bc0158bd3ca9c1b951e5c4f7a0ca09b26ac1a851e4c60d6f0efc23333dc5c274cf72a96ded73f994b375a1fc130cf75530913f992575a5b7a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869c7612799cbd03091b0ec6b4fddb8b7669050e1eda1e7ee26ffbfdd6a1d30493ea1307256d74cca2af23820129354131e6fe9b93bf3ab27dfff89dc1b1dab3"} 20:30:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:30:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:30:43 INFO - Contents: 20:30:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e7710df7439ee90b6c4796537a030121ea17587f8ca334421275c10fef920ba639ef26801bfdaed6a9ba728b015c353666466dc478dfd39a0fc4dcadcd45a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43a982fdf5ef7bc0158bd3ca9c1b951e5c4f7a0ca09b26ac1a851e4c60d6f0efc23333dc5c274cf72a96ded73f994b375a1fc130cf75530913f992575a5b7a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869c7612799cbd03091b0ec6b4fddb8b7669050e1eda1e7ee26ffbfdd6a1d30493ea1307256d74cca2af23820129354131e6fe9b93bf3ab27dfff89dc1b1dab3"} 20:30:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:43 INFO - Copying logs to upload dir... 20:30:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:30:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.710165 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-29 20:30:43.897207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 20:30:43.901614) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 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/sha512/25e7710df7439ee90b6c4796537a030121ea17587f8ca334421275c10fef920ba639ef26801bfdaed6a9ba728b015c353666466dc478dfd39a0fc4dcadcd45a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43a982fdf5ef7bc0158bd3ca9c1b951e5c4f7a0ca09b26ac1a851e4c60d6f0efc23333dc5c274cf72a96ded73f994b375a1fc130cf75530913f992575a5b7a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869c7612799cbd03091b0ec6b4fddb8b7669050e1eda1e7ee26ffbfdd6a1d30493ea1307256d74cca2af23820129354131e6fe9b93bf3ab27dfff89dc1b1dab3"} build_url:https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/YPRmKzGQR6yiiaJhvRWJkw/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/sha512/25e7710df7439ee90b6c4796537a030121ea17587f8ca334421275c10fef920ba639ef26801bfdaed6a9ba728b015c353666466dc478dfd39a0fc4dcadcd45a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43a982fdf5ef7bc0158bd3ca9c1b951e5c4f7a0ca09b26ac1a851e4c60d6f0efc23333dc5c274cf72a96ded73f994b375a1fc130cf75530913f992575a5b7a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869c7612799cbd03091b0ec6b4fddb8b7669050e1eda1e7ee26ffbfdd6a1d30493ea1307256d74cca2af23820129354131e6fe9b93bf3ab27dfff89dc1b1dab3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 20:30:43.926326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:30:43.926606) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469840055.988847-1578318597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:30:44.010951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 20:30:44.011265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 20:30:44.011597) ========= ========= Total master_lag: 0.18 =========