builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1469636114.51 results: success (0) buildid: 20160727073613 builduid: f4f4e3b2fac246da9258ecb3ceef7580 revision: fef429fba4c64c5b9c0c823a6ab713edbbcd4220 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.512718) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.513300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.513588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.528305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.528589) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 09:15:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2016-07-27 09:15:14 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174346 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.743270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.743579) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.165708 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:14.919685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 09:15:14.920038) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fef429fba4c64c5b9c0c823a6ab713edbbcd4220 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fef429fba4c64c5b9c0c823a6ab713edbbcd4220 --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=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 09:15:14,816 truncating revision to first 12 chars 2016-07-27 09:15:14,816 Setting DEBUG logging. 2016-07-27 09:15:14,817 attempt 1/10 2016-07-27 09:15:14,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fef429fba4c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 09:15:15,770 unpacking tar archive at: mozilla-central-fef429fba4c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 09:15:16.196945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:16.197340) ========= script_repo_revision: fef429fba4c64c5b9c0c823a6ab713edbbcd4220 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:16.197881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:16.198289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 09:15:16.209818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-27 09:15:16.210165) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:16 INFO - MultiFileLogger online at 20160727 09:15:16 in /builds/slave/test 09:15:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:15:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:16 INFO - {'append_to_log': False, 09:15:16 INFO - 'base_work_dir': '/builds/slave/test', 09:15:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:15:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:16 INFO - 'branch': 'Firefox-Non-PGO', 09:15:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:16 INFO - 'config_files': ('talos/linux_config.py',), 09:15:16 INFO - 'default_actions': ('clobber', 09:15:16 INFO - 'read-buildbot-config', 09:15:16 INFO - 'download-and-extract', 09:15:16 INFO - 'populate-webroot', 09:15:16 INFO - 'create-virtualenv', 09:15:16 INFO - 'install', 09:15:16 INFO - 'run-tests'), 09:15:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:16 INFO - 'download_minidump_stackwalk': True, 09:15:16 INFO - 'download_symbols': 'ondemand', 09:15:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:16 INFO - 'installer_path': 'installer.exe', 09:15:16 INFO - 'log_level': 'info', 09:15:16 INFO - 'log_name': 'talos', 09:15:16 INFO - 'log_to_console': True, 09:15:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:16 INFO - 'opt_config_files': (), 09:15:16 INFO - 'pip_index': False, 09:15:16 INFO - 'sps_profile': False, 09:15:16 INFO - 'sps_profile_interval': 0, 09:15:16 INFO - 'suite': 'dromaeojs', 09:15:16 INFO - 'system_bits': '32', 09:15:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:16 INFO - 'title': 'talos-linux64-ix-029', 09:15:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:16 INFO - 'use_talos_json': True, 09:15:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:16 INFO - 'work_dir': 'build'} 09:15:16 INFO - [mozharness: 2016-07-27 16:15:16.336554Z] Running clobber step. 09:15:16 INFO - Running pre-action listener: _resource_record_pre_action 09:15:16 INFO - Running main action method: clobber 09:15:16 INFO - rmtree: /builds/slave/test/build 09:15:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:17 INFO - Running post-action listener: _resource_record_post_action 09:15:17 INFO - [mozharness: 2016-07-27 16:15:17.526928Z] Finished clobber step (success) 09:15:17 INFO - [mozharness: 2016-07-27 16:15:17.527093Z] Running read-buildbot-config step. 09:15:17 INFO - Running pre-action listener: _resource_record_pre_action 09:15:17 INFO - Running main action method: read_buildbot_config 09:15:17 INFO - Using buildbot properties: 09:15:17 INFO - { 09:15:17 INFO - "project": "", 09:15:17 INFO - "product": "firefox", 09:15:17 INFO - "script_repo_revision": "production", 09:15:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:15:17 INFO - "repository": "", 09:15:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:15:17 INFO - "buildid": "20160727073613", 09:15:17 INFO - "pgo_build": "False", 09:15:17 INFO - "basedir": "/builds/slave/test", 09:15:17 INFO - "buildnumber": 570, 09:15:17 INFO - "slavename": "talos-linux64-ix-029", 09:15:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:15:17 INFO - "platform": "ubuntu64_hw", 09:15:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:15:17 INFO - "branch": "mozilla-central", 09:15:17 INFO - "repo_path": "mozilla-central", 09:15:17 INFO - "revision": "fef429fba4c64c5b9c0c823a6ab713edbbcd4220", 09:15:17 INFO - "stage_platform": "linux64", 09:15:17 INFO - "builduid": "f4f4e3b2fac246da9258ecb3ceef7580", 09:15:17 INFO - "slavebuilddir": "test" 09:15:17 INFO - } 09:15:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:15:17 INFO - Running post-action listener: _resource_record_post_action 09:15:17 INFO - [mozharness: 2016-07-27 16:15:17.530808Z] Finished read-buildbot-config step (success) 09:15:17 INFO - [mozharness: 2016-07-27 16:15:17.530939Z] Running download-and-extract step. 09:15:17 INFO - Running pre-action listener: _resource_record_pre_action 09:15:17 INFO - Running main action method: download_and_extract 09:15:17 INFO - mkdir: /builds/slave/test/build/tests 09:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:17 INFO - https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:15:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:15:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:15:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:15:18 INFO - Downloaded 1361 bytes. 09:15:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:15:18 INFO - Using the following test package requirements: 09:15:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:15:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'jsshell-linux-x86_64.zip'], 09:15:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:15:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:15:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15: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')]} 09:15:18 INFO - https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:19 INFO - Downloaded 22746495 bytes. 09:15:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:15:20 INFO - Return code: 0 09:15:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:20 INFO - https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:21 INFO - Downloaded 22746495 bytes. 09:15:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:15:24 INFO - Return code: 0 09:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:24 INFO - https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:15:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:15:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:15:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:15:25 INFO - Downloaded 14413725 bytes. 09:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:15:25 INFO - Return code: 0 09:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:25 INFO - https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:15:26 INFO - Downloaded 57157271 bytes. 09:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:15:26 INFO - mkdir: /builds/slave/test/properties 09:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:26 INFO - Contents: 09:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:15:27 INFO - Running post-action listener: _resource_record_post_action 09:15:27 INFO - Running post-action listener: set_extra_try_arguments 09:15:27 INFO - [mozharness: 2016-07-27 16:15:27.304837Z] Finished download-and-extract step (success) 09:15:27 INFO - [mozharness: 2016-07-27 16:15:27.305071Z] Running populate-webroot step. 09:15:27 INFO - Running pre-action listener: _resource_record_pre_action 09:15:27 INFO - Running main action method: populate_webroot 09:15:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:27 INFO - '--tppagecycles', 09:15:27 INFO - '7'], 09:15:27 INFO - 'tests': ['tsvgm']}}, 09:15:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['damp', 'tps']}, 09:15:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'tests': ['damp', 'tps']}, 09:15:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['dromaeo_dom']}, 09:15:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['basic_compositor_video']}, 09:15:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['a11yr', 09:15:27 INFO - 'ts_paint', 09:15:27 INFO - 'tpaint', 09:15:27 INFO - 'sessionrestore', 09:15:27 INFO - 'sessionrestore_no_auto_restore', 09:15:27 INFO - 'tabpaint']}, 09:15:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['tsvgx', 09:15:27 INFO - 'tsvgr_opacity', 09:15:27 INFO - 'tart', 09:15:27 INFO - 'tscrollx', 09:15:27 INFO - 'cart']}, 09:15:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:27 INFO - 'tsvgr_opacity', 09:15:27 INFO - 'tart', 09:15:27 INFO - 'tscrollx', 09:15:27 INFO - 'cart']}, 09:15:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'talos_options': ['--disable-e10s'], 09:15:27 INFO - 'tests': ['tp5o']}, 09:15:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'tests': ['tp5o']}, 09:15:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'talos_options': ['--disable-e10s', 09:15:27 INFO - '--xperf_path', 09:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:27 INFO - 'tests': ['tp5n']}, 09:15:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:27 INFO - 'talos_options': ['--xperf_path', 09:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:27 INFO - 'tests': ['tp5n']}}, 09:15:27 INFO - 'talos.zip': {'path': '', 09:15:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:27 INFO - Running post-action listener: _resource_record_post_action 09:15:27 INFO - [mozharness: 2016-07-27 16:15:27.321408Z] Finished populate-webroot step (success) 09:15:27 INFO - [mozharness: 2016-07-27 16:15:27.321498Z] Running create-virtualenv step. 09:15:27 INFO - Running pre-action listener: _resource_record_pre_action 09:15:27 INFO - Running main action method: create_virtualenv 09:15:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:15:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:27 INFO - Using real prefix '/usr' 09:15:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:30 INFO - Installing pip.................done. 09:15:30 INFO - Return code: 0 09:15:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15: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', 'pip>=1.5'] in /builds/slave/test/build 09:15: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 pip>=1.5 09:15:30 INFO - Using env: {'DISPLAY': ':0', 09:15:30 INFO - 'HOME': '/home/cltbld', 09:15:30 INFO - 'LANG': 'en_US.UTF-8', 09:15:30 INFO - 'LANGUAGE': 'en_US:en', 09:15:30 INFO - 'LOGNAME': 'cltbld', 09:15:30 INFO - 'MAIL': '/var/mail/cltbld', 09:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:30 INFO - 'MOZ_NO_REMOTE': '1', 09:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:30 INFO - 'NO_EM_RESTART': '1', 09:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:30 INFO - 'PWD': '/builds/slave/test', 09:15:30 INFO - 'SHELL': '/bin/bash', 09:15:30 INFO - 'SHLVL': '1', 09:15:30 INFO - 'TERM': 'linux', 09:15:30 INFO - 'TMOUT': '86400', 09:15:30 INFO - 'USER': 'cltbld', 09:15:30 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:30 INFO - '_': '/tools/buildbot/bin/python'} 09:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:15:36 INFO - Cleaning up... 09:15:36 INFO - Return code: 0 09:15:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:36 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:15:36 INFO - Using env: {'DISPLAY': ':0', 09:15:36 INFO - 'HOME': '/home/cltbld', 09:15:36 INFO - 'LANG': 'en_US.UTF-8', 09:15:36 INFO - 'LANGUAGE': 'en_US:en', 09:15:36 INFO - 'LOGNAME': 'cltbld', 09:15:36 INFO - 'MAIL': '/var/mail/cltbld', 09:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:36 INFO - 'MOZ_NO_REMOTE': '1', 09:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:36 INFO - 'NO_EM_RESTART': '1', 09:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:36 INFO - 'PWD': '/builds/slave/test', 09:15:36 INFO - 'SHELL': '/bin/bash', 09:15:36 INFO - 'SHLVL': '1', 09:15:36 INFO - 'TERM': 'linux', 09:15:36 INFO - 'TMOUT': '86400', 09:15:36 INFO - 'USER': 'cltbld', 09:15:36 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:36 INFO - '_': '/tools/buildbot/bin/python'} 09:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:37 INFO - Downloading/unpacking psutil>=3.1.1 09:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:39 INFO - Installing collected packages: psutil 09:15:39 INFO - Running setup.py install for psutil 09:15:39 INFO - building 'psutil._psutil_linux' extension 09:15:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:15:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:15:40 INFO - building 'psutil._psutil_posix' extension 09:15:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:15:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:40 INFO - Successfully installed psutil 09:15:40 INFO - Cleaning up... 09:15:40 INFO - Return code: 0 09:15:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:40 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:15:40 INFO - Using env: {'DISPLAY': ':0', 09:15:40 INFO - 'HOME': '/home/cltbld', 09:15:40 INFO - 'LANG': 'en_US.UTF-8', 09:15:40 INFO - 'LANGUAGE': 'en_US:en', 09:15:40 INFO - 'LOGNAME': 'cltbld', 09:15:40 INFO - 'MAIL': '/var/mail/cltbld', 09:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:40 INFO - 'MOZ_NO_REMOTE': '1', 09:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:40 INFO - 'NO_EM_RESTART': '1', 09:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:40 INFO - 'PWD': '/builds/slave/test', 09:15:40 INFO - 'SHELL': '/bin/bash', 09:15:40 INFO - 'SHLVL': '1', 09:15:40 INFO - 'TERM': 'linux', 09:15:40 INFO - 'TMOUT': '86400', 09:15:40 INFO - 'USER': 'cltbld', 09:15:40 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:40 INFO - '_': '/tools/buildbot/bin/python'} 09:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:15:42 INFO - Installing collected packages: mozsystemmonitor 09:15:42 INFO - Running setup.py install for mozsystemmonitor 09:15:42 INFO - Successfully installed mozsystemmonitor 09:15:42 INFO - Cleaning up... 09:15:42 INFO - Return code: 0 09:15:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:42 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:15:42 INFO - Using env: {'DISPLAY': ':0', 09:15:42 INFO - 'HOME': '/home/cltbld', 09:15:42 INFO - 'LANG': 'en_US.UTF-8', 09:15:42 INFO - 'LANGUAGE': 'en_US:en', 09:15:42 INFO - 'LOGNAME': 'cltbld', 09:15:42 INFO - 'MAIL': '/var/mail/cltbld', 09:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:42 INFO - 'MOZ_NO_REMOTE': '1', 09:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:42 INFO - 'NO_EM_RESTART': '1', 09:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:42 INFO - 'PWD': '/builds/slave/test', 09:15:42 INFO - 'SHELL': '/bin/bash', 09:15:42 INFO - 'SHLVL': '1', 09:15:42 INFO - 'TERM': 'linux', 09:15:42 INFO - 'TMOUT': '86400', 09:15:42 INFO - 'USER': 'cltbld', 09:15:42 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:42 INFO - '_': '/tools/buildbot/bin/python'} 09:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:45 INFO - warning: no files found matching '*.txt' 09:15:45 INFO - no previously-included directories found matching 'build' 09:15:45 INFO - no previously-included directories found matching 'dist' 09:15:45 INFO - no previously-included directories found matching '.git*' 09:15:45 INFO - Installing collected packages: jsonschema, functools32 09:15:45 INFO - Running setup.py install for functools32 09:15:45 INFO - warning: no files found matching '*.txt' 09:15:45 INFO - no previously-included directories found matching 'build' 09:15:45 INFO - no previously-included directories found matching 'dist' 09:15:45 INFO - no previously-included directories found matching '.git*' 09:15:45 INFO - Successfully installed jsonschema functools32 09:15:45 INFO - Cleaning up... 09:15:45 INFO - Return code: 0 09:15:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:45 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:15:45 INFO - Using env: {'DISPLAY': ':0', 09:15:45 INFO - 'HOME': '/home/cltbld', 09:15:45 INFO - 'LANG': 'en_US.UTF-8', 09:15:45 INFO - 'LANGUAGE': 'en_US:en', 09:15:45 INFO - 'LOGNAME': 'cltbld', 09:15:45 INFO - 'MAIL': '/var/mail/cltbld', 09:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:45 INFO - 'MOZ_NO_REMOTE': '1', 09:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:45 INFO - 'NO_EM_RESTART': '1', 09:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:45 INFO - 'PWD': '/builds/slave/test', 09:15:45 INFO - 'SHELL': '/bin/bash', 09:15:45 INFO - 'SHLVL': '1', 09:15:45 INFO - 'TERM': 'linux', 09:15:45 INFO - 'TMOUT': '86400', 09:15:45 INFO - 'USER': 'cltbld', 09:15:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:45 INFO - '_': '/tools/buildbot/bin/python'} 09:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:45 INFO - Cleaning up... 09:15:45 INFO - Return code: 0 09:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:45 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:45 INFO - Using env: {'DISPLAY': ':0', 09:15:45 INFO - 'HOME': '/home/cltbld', 09:15:45 INFO - 'LANG': 'en_US.UTF-8', 09:15:45 INFO - 'LANGUAGE': 'en_US:en', 09:15:45 INFO - 'LOGNAME': 'cltbld', 09:15:45 INFO - 'MAIL': '/var/mail/cltbld', 09:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:45 INFO - 'MOZ_NO_REMOTE': '1', 09:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:45 INFO - 'NO_EM_RESTART': '1', 09:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:45 INFO - 'PWD': '/builds/slave/test', 09:15:45 INFO - 'SHELL': '/bin/bash', 09:15:45 INFO - 'SHLVL': '1', 09:15:45 INFO - 'TERM': 'linux', 09:15:45 INFO - 'TMOUT': '86400', 09:15:45 INFO - 'USER': 'cltbld', 09:15:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:45 INFO - '_': '/tools/buildbot/bin/python'} 09:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:48 INFO - Downloading docopt-0.6.1.tar.gz 09:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:48 INFO - Running setup.py install for blobuploader 09:15:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:48 INFO - Running setup.py install for requests 09:15:48 INFO - Running setup.py install for docopt 09:15:49 INFO - Successfully installed blobuploader requests docopt 09:15:49 INFO - Cleaning up... 09:15:49 INFO - Return code: 0 09:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:49 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:15:49 INFO - Using env: {'DISPLAY': ':0', 09:15:49 INFO - 'HOME': '/home/cltbld', 09:15:49 INFO - 'LANG': 'en_US.UTF-8', 09:15:49 INFO - 'LANGUAGE': 'en_US:en', 09:15:49 INFO - 'LOGNAME': 'cltbld', 09:15:49 INFO - 'MAIL': '/var/mail/cltbld', 09:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:49 INFO - 'MOZ_NO_REMOTE': '1', 09:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:49 INFO - 'NO_EM_RESTART': '1', 09:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:49 INFO - 'PWD': '/builds/slave/test', 09:15:49 INFO - 'SHELL': '/bin/bash', 09:15:49 INFO - 'SHLVL': '1', 09:15:49 INFO - 'TERM': 'linux', 09:15:49 INFO - 'TMOUT': '86400', 09:15:49 INFO - 'USER': 'cltbld', 09:15:49 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:49 INFO - '_': '/tools/buildbot/bin/python'} 09:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:49 INFO - Running setup.py (path:/tmp/pip-Wmct63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:49 INFO - Running setup.py (path:/tmp/pip-BQdxga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:49 INFO - Running setup.py (path:/tmp/pip-k7khLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:49 INFO - Running setup.py (path:/tmp/pip-ue3_Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:49 INFO - Running setup.py (path:/tmp/pip-HhL5M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:49 INFO - Running setup.py (path:/tmp/pip-B9ng1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:49 INFO - Running setup.py (path:/tmp/pip-TyPDs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:49 INFO - Running setup.py (path:/tmp/pip-9p0oHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:49 INFO - Running setup.py (path:/tmp/pip-zinNm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:50 INFO - Running setup.py (path:/tmp/pip-GsvV0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:50 INFO - Running setup.py (path:/tmp/pip-XFg3ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:50 INFO - Running setup.py (path:/tmp/pip-08Zlxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:50 INFO - Running setup.py (path:/tmp/pip-AW4e5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:50 INFO - Running setup.py (path:/tmp/pip-GyEoi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:50 INFO - Running setup.py (path:/tmp/pip-Y0Rd1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:50 INFO - Running setup.py (path:/tmp/pip-Uv9SIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:50 INFO - Running setup.py (path:/tmp/pip-iHTjKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:50 INFO - Running setup.py install for manifestparser 09:15:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:50 INFO - Running setup.py install for mozcrash 09:15:50 INFO - Running setup.py install for mozdebug 09:15:50 INFO - Running setup.py install for mozdevice 09:15:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozfile 09:15:51 INFO - Running setup.py install for mozhttpd 09:15:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozinfo 09:15:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozInstall 09:15:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozleak 09:15:51 INFO - Running setup.py install for mozlog 09:15:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for moznetwork 09:15:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozprocess 09:15:51 INFO - Running setup.py install for mozprofile 09:15:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:51 INFO - Running setup.py install for mozrunner 09:15:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:52 INFO - Running setup.py install for mozscreenshot 09:15:52 INFO - Running setup.py install for moztest 09:15:52 INFO - Running setup.py install for mozversion 09:15:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:52 INFO - Cleaning up... 09:15:52 INFO - Return code: 0 09:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:52 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:15:52 INFO - Using env: {'DISPLAY': ':0', 09:15:52 INFO - 'HOME': '/home/cltbld', 09:15:52 INFO - 'LANG': 'en_US.UTF-8', 09:15:52 INFO - 'LANGUAGE': 'en_US:en', 09:15:52 INFO - 'LOGNAME': 'cltbld', 09:15:52 INFO - 'MAIL': '/var/mail/cltbld', 09:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:52 INFO - 'MOZ_NO_REMOTE': '1', 09:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:52 INFO - 'NO_EM_RESTART': '1', 09:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:52 INFO - 'PWD': '/builds/slave/test', 09:15:52 INFO - 'SHELL': '/bin/bash', 09:15:52 INFO - 'SHLVL': '1', 09:15:52 INFO - 'TERM': 'linux', 09:15:52 INFO - 'TMOUT': '86400', 09:15:52 INFO - 'USER': 'cltbld', 09:15:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:52 INFO - '_': '/tools/buildbot/bin/python'} 09:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:52 INFO - Running setup.py (path:/tmp/pip-cahqu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:52 INFO - Running setup.py (path:/tmp/pip-gUEKxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:52 INFO - Running setup.py (path:/tmp/pip-WF8_gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:52 INFO - Running setup.py (path:/tmp/pip-MyqtsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:52 INFO - Running setup.py (path:/tmp/pip-vWjhRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:52 INFO - Running setup.py (path:/tmp/pip-oamo9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:53 INFO - Running setup.py (path:/tmp/pip-vigyZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:53 INFO - Running setup.py (path:/tmp/pip-oNZAAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:53 INFO - Running setup.py (path:/tmp/pip-dtSytO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:53 INFO - Running setup.py (path:/tmp/pip-O_tmy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:53 INFO - Running setup.py (path:/tmp/pip-QDrkCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:53 INFO - Running setup.py (path:/tmp/pip-LhYxmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:53 INFO - Running setup.py (path:/tmp/pip-82ZKJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:53 INFO - Running setup.py (path:/tmp/pip-MrTN6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:53 INFO - Running setup.py (path:/tmp/pip-_jqMn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:53 INFO - Running setup.py (path:/tmp/pip-5mJBcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:53 INFO - Running setup.py (path:/tmp/pip-H7tjXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:55 INFO - Downloading blessings-1.6.tar.gz 09:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:55 INFO - Installing collected packages: blessings 09:15:55 INFO - Running setup.py install for blessings 09:15:55 INFO - Successfully installed blessings 09:15:55 INFO - Cleaning up... 09:15:56 INFO - Return code: 0 09:15:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Current package versions: 09:15:56 INFO - argparse == 1.2.1 09:15:56 INFO - blessings == 1.6 09:15:56 INFO - blobuploader == 1.2.4 09:15:56 INFO - docopt == 0.6.1 09:15:56 INFO - functools32 == 3.2.3-2 09:15:56 INFO - jsonschema == 2.5.1 09:15:56 INFO - manifestparser == 1.1 09:15:56 INFO - mozInstall == 1.12 09:15:56 INFO - mozcrash == 0.17 09:15:56 INFO - mozdebug == 0.1 09:15:56 INFO - mozdevice == 0.48 09:15:56 INFO - mozfile == 1.2 09:15:56 INFO - mozhttpd == 0.7 09:15:56 INFO - mozinfo == 0.9 09:15:56 INFO - mozleak == 0.1 09:15:56 INFO - mozlog == 3.3 09:15:56 INFO - moznetwork == 0.27 09:15:56 INFO - mozprocess == 0.23 09:15:56 INFO - mozprofile == 0.28 09:15:56 INFO - mozrunner == 6.12 09:15:56 INFO - mozscreenshot == 0.1 09:15:56 INFO - mozsystemmonitor == 0.3 09:15:56 INFO - moztest == 0.7 09:15:56 INFO - mozversion == 1.4 09:15:56 INFO - psutil == 3.1.1 09:15:56 INFO - requests == 1.2.3 09:15:56 INFO - wsgiref == 0.1.2 09:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:56 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:15:56 INFO - Using env: {'DISPLAY': ':0', 09:15:56 INFO - 'HOME': '/home/cltbld', 09:15:56 INFO - 'LANG': 'en_US.UTF-8', 09:15:56 INFO - 'LANGUAGE': 'en_US:en', 09:15:56 INFO - 'LOGNAME': 'cltbld', 09:15:56 INFO - 'MAIL': '/var/mail/cltbld', 09:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:56 INFO - 'MOZ_NO_REMOTE': '1', 09:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:56 INFO - 'NO_EM_RESTART': '1', 09:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:56 INFO - 'PWD': '/builds/slave/test', 09:15:56 INFO - 'SHELL': '/bin/bash', 09:15:56 INFO - 'SHLVL': '1', 09:15:56 INFO - 'TERM': 'linux', 09:15:56 INFO - 'TMOUT': '86400', 09:15:56 INFO - 'USER': 'cltbld', 09:15:56 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:56 INFO - '_': '/tools/buildbot/bin/python'} 09:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:15:56 INFO - Cleaning up... 09:15:56 INFO - Return code: 0 09:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:56 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 0x1c6d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:15:56 INFO - Using env: {'DISPLAY': ':0', 09:15:56 INFO - 'HOME': '/home/cltbld', 09:15:56 INFO - 'LANG': 'en_US.UTF-8', 09:15:56 INFO - 'LANGUAGE': 'en_US:en', 09:15:56 INFO - 'LOGNAME': 'cltbld', 09:15:56 INFO - 'MAIL': '/var/mail/cltbld', 09:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:56 INFO - 'MOZ_NO_REMOTE': '1', 09:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:56 INFO - 'NO_EM_RESTART': '1', 09:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:56 INFO - 'PWD': '/builds/slave/test', 09:15:56 INFO - 'SHELL': '/bin/bash', 09:15:56 INFO - 'SHLVL': '1', 09:15:56 INFO - 'TERM': 'linux', 09:15:56 INFO - 'TMOUT': '86400', 09:15:56 INFO - 'USER': 'cltbld', 09:15:56 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:56 INFO - '_': '/tools/buildbot/bin/python'} 09:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:15:56 INFO - Cleaning up... 09:15:56 INFO - Return code: 0 09:15:56 INFO - Running post-action listener: _resource_record_post_action 09:15:56 INFO - Running post-action listener: _start_resource_monitoring 09:15:56 INFO - Starting resource monitoring. 09:15:56 INFO - [mozharness: 2016-07-27 16:15:56.689651Z] Finished create-virtualenv step (success) 09:15:56 INFO - [mozharness: 2016-07-27 16:15:56.690605Z] Running install step. 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: install 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:56 INFO - Reading from file tmpfile_stdout 09:15:56 INFO - Output received: 09:15:56 INFO - Usage: mozinstall [options] installer 09:15:56 INFO - Options: 09:15:56 INFO - -h, --help show this help message and exit 09:15:56 INFO - -d DEST, --destination=DEST 09:15:56 INFO - Directory to install application into. [default: 09:15:56 INFO - "/builds/slave/test"] 09:15:56 INFO - --app=APP Application being installed. [default: firefox] 09:15:56 INFO - mkdir: /builds/slave/test/build/application 09:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:16:13 INFO - Reading from file tmpfile_stdout 09:16:13 INFO - Output received: 09:16:13 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:13 INFO - Running post-action listener: _resource_record_post_action 09:16:13 INFO - [mozharness: 2016-07-27 16:16:13.396053Z] Finished install step (success) 09:16:13 INFO - [mozharness: 2016-07-27 16:16:13.396324Z] Running run-tests step. 09:16:13 INFO - Running pre-action listener: _resource_record_pre_action 09:16:13 INFO - Running main action method: run_tests 09:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:13 INFO - Python 2.7.3 09:16:13 INFO - Return code: 0 09:16:13 INFO - grabbing minidump binary from tooltool 09:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:13 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 0x1f2c3b0>, '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 0x1f2d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:16:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:16:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:16:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:13 INFO - Return code: 0 09:16:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 09:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 09:16:13 INFO - Using env: {'DISPLAY': ':0', 09:16:13 INFO - 'HOME': '/home/cltbld', 09:16:13 INFO - 'LANG': 'en_US.UTF-8', 09:16:13 INFO - 'LANGUAGE': 'en_US:en', 09:16:13 INFO - 'LOGNAME': 'cltbld', 09:16:13 INFO - 'MAIL': '/var/mail/cltbld', 09:16:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:13 INFO - 'MOZ_NO_REMOTE': '1', 09:16:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:13 INFO - 'NO_EM_RESTART': '1', 09:16:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:13 INFO - 'PWD': '/builds/slave/test', 09:16:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:13 INFO - 'SHELL': '/bin/bash', 09:16:13 INFO - 'SHLVL': '1', 09:16:13 INFO - 'TERM': 'linux', 09:16:13 INFO - 'TMOUT': '86400', 09:16:13 INFO - 'USER': 'cltbld', 09:16:13 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568', 09:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:13 INFO - '_': '/tools/buildbot/bin/python'} 09:16:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 09:16:13 INFO - mozversion application_buildid: 20160727073613 09:16:13 INFO - mozversion application_changeset: fef429fba4c64c5b9c0c823a6ab713edbbcd4220 09:16:13 INFO - mozversion application_display_name: Nightly 09:16:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:13 INFO - mozversion application_name: Firefox 09:16:13 INFO - mozversion application_remotingname: firefox 09:16:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:13 INFO - mozversion application_vendor: Mozilla 09:16:13 INFO - mozversion application_version: 50.0a1 09:16:13 INFO - mozversion platform_buildid: 20160727073613 09:16:13 INFO - mozversion platform_changeset: fef429fba4c64c5b9c0c823a6ab713edbbcd4220 09:16:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:13 INFO - mozversion platform_version: 50.0a1 09:16:13 INFO - using testdate: 1469636173 09:16:13 INFO - actual date: 1469636173 09:16:13 INFO - starting webserver on 'localhost:36871' 09:16:13 INFO - SUITE-START | Running 2 tests 09:16:13 INFO - TEST-START | dromaeo_css 09:16:13 INFO - operating with platform_type : linux_ 09:16:13 INFO - Initialising browser for dromaeo_css test... 09:16:13 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaTcE4/profile http://localhost:36871/getInfo.html) 09:16:19 INFO - PROCESS | 3310 | JavaScript error: , line 0: uncaught exception: undefined 09:16:20 INFO - PROCESS | 3310 | __metrics Screen width/height:1600/1200 09:16:20 INFO - PROCESS | 3310 | colorDepth:24 09:16:20 INFO - PROCESS | 3310 | Browser inner width/height: 1024/697 09:16:20 INFO - PROCESS | 3310 | __metrics 09:16:21 INFO - PROCESS | 3310 | 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" 09:16:21 INFO - PROCESS | 3310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:22 INFO - TEST-INFO | 3310: exit 0 09:16:22 INFO - Browser initialized. 09:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:22 INFO - TEST-INFO | started process 3387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaTcE4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:34 INFO - PROCESS | 3387 | RSS: Main: 159277056 09:16:34 INFO - PROCESS | 3387 | 09:17:26 INFO - PROCESS | 3387 | 1469636246279 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:19:38 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36871/tests/dromaeo/cssquery-ext.html) 09:19:39 INFO - PROCESS | 3387 | RSS: Main: 281456640 09:19:39 INFO - PROCESS | 3387 | 09:22:42 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-ext.html (next: http://localhost:36871/tests/dromaeo/cssquery-jquery.html) 09:22:43 INFO - PROCESS | 3387 | RSS: Main: 241844224 09:22:43 INFO - PROCESS | 3387 | 09:25:45 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36871/tests/dromaeo/cssquery-mootools.html) 09:25:46 INFO - PROCESS | 3387 | RSS: Main: 186257408 09:25:46 INFO - PROCESS | 3387 | 09:28:48 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36871/tests/dromaeo/cssquery-prototype.html) 09:28:49 INFO - PROCESS | 3387 | RSS: Main: 185856000 09:28:49 INFO - PROCESS | 3387 | 09:31:52 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36871/tests/dromaeo/cssquery-yui.html) 09:31:52 INFO - PROCESS | 3387 | RSS: Main: 185565184 09:31:52 INFO - PROCESS | 3387 | 09:34:55 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:36871/tests/dromaeo/cssquery-yui.html (next: http://localhost:36871/tests/dromaeo/cssquery-dojo.html) 09:34:56 INFO - PROCESS | 3387 | RSS: Main: 265281536 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | __start_tp_report 09:34:56 INFO - PROCESS | 3387 | _x_x_mozilla_page_load 09:34:56 INFO - PROCESS | 3387 | _x_x_mozilla_page_load_details 09:34:56 INFO - PROCESS | 3387 | |i|pagename|runs| 09:34:56 INFO - PROCESS | 3387 | |0;dojo.html;2618.92143235703;2625.973740262597;2647.5499165141923;2660.454606805604;2661.401184733435;4693.882652933678;4727.598154156896;4771.427428708551;4782.593479554233;4805.927911081332;4753.572178503934;4787.40157480315;4813.109574728669;4819.397575303087;4829.227323628212;4322.13557288542;4336.566343365654;4358.6077253047215;4377.6935614507;4446.688731788776;4402.537733537981;4429.557044295577;4487.483939346968;4518.480374756896;4533.455985281771;4435.733855968652;4482.394876691637;4483.39474170986;4490.304002879542;4529.433820772403;4264.786760661986;4321.783910804447;4328.5022222444195;4377.190219809346;4389.604935555815;4307.483102027777;4330.610245077958;4350.15172041452;4414.426124603781;4445.955540444586;4787.186178349689;4812.855614331575;4823.807047718087;4824.662273640846;4834.709917404967;4951.306817045616;5154.742262886841;5161.896762064737;5167.044096842059;5173.767180476888;5029.245613158019;5050.9494905051215;5101.591872650216;5125.897482050338;5177.8187763428095;4789.473157952622;4813.109574728686;4820.517948205152;4823.782929768169;4828.493008234155;5121.641485096007;5206.97396513015;5266.0257852297445;5271.868203294948;5273.499017593399;4986.6758660687665;5055.570276526463;5066.569341605931;5076.213186956028;5081.4918508148885;5113.054084994214;5129.230615407719;5163.251328557338;5176.327077479904;5183.300254465599;5000.699958002531;5036.420811606639;5064.34163558735;5069.619778516626;5126.846194614168;5050;5074.695518268842;5084;5131.153359695683;5134.101532231844;4416.183006143874;4424.911501769947;4425.269830477935;4427.787843439007;4473.3960915276675;3838.7120965927666;3859.4017927221325;3883.650471457526;3887.5140607424073;3919.6668283195677;4355.956440435619;4369.104333611602;4395.582419670126;4423.07115505741;4495.887602809956;5145.819896303611;5153.3815942087185;5154.639175257771;5168.302279192261;5212.739363031833;4437.866863994085;4444.2222611042935;4449.510553839075;4453.265211240174;4491.303847903515;4532.750698711537;4586.931196032062;4602.815887364468;4622.098690755338;4679.883002924954;4768.403949506312;4778.904421911612;4788.281757736368;4788.3056956741775;4832.323474713613;5103.464136265638;5107.514786095315;5108.28484012246;5114.590832733298;5118.616103792156;4637.837675681335;4772.475027747015;4791.065742180242;4802.639802014793;4879.048585525788;5041;5044.369453818273;5060.721660308718;5066.645334826527;5116.948830511647;5124.231365295235;5132.820351287687;5145.022445735298;5146.536811686966;5148.382194136728;4863.2461968394955;4935.284383764406;4959.677620954626;4971.975140124277;5019.196928491424;4976.104301225814;4977.552020318189;4981.501849815135;4987.977464619817;4991.176455884884;4891.1685013548495;4901.436334821398;4939.382577177853;4950.975245123751;4956.628252881121;4838.830640927551;4903.970166265124;4929.260610908393;4935.98812243482;4943.901121977612;4887.59812861785;4898.877528061685;4899.020195960751;4901.460839307744;4934.679245849152 09:34:56 INFO - PROCESS | 3387 | |1;ext.html;539.3195631418392;570.6347937320113;579.4611011759063;591.2668291318764;596.3738075021228;28637.284067898312;38130.618693813056;39278.41082383763;39405;43600.56399436013;40682.38976415356;41066.58933410673;41068.17863642733;41167;41169.58830411695;7283.053203083592;7662.693492260317;7802.765917022499;7808.297253247207;7818.843623127534;7291.4895957283015;7493.363064139555;7509.098908131032;9654.372465789736;9882.110610045094;10016.198704103654;10048.743907011623;10075.19398448126;10080.143187829044;10090.041446062613;9845.60617575296;9902.158316543031;9918.156956658693;9986.051325124101;9994.400335979792;10016.89983100167;10087.04173103554;10088.445135517544;10092.848607270824;10102.848457273147;37247.81376093102;37659.811700941595;37712;37717.62282377196;37802.81098594517;2816.985915070432;2893.23329317731;3001.5497675348656;3066.5246886732593;3627.437747149196;28515.287117822012;28601;29097.563536546968;29418.264543386373;29481.115566533037;3260.8695652173883;3269.362474317509;3297.554830097954;3331.8667253309836;3343.030521148864;238323;239995;241206;241449;242778.7861060701;28734.281642958675;29741.702582974325;54270.45729542654;54587;54701.45298547043;32135.196620084684;32251.35497290088;32307.676923230465;32404.189895252806;32483;12201.328926908927;12250.387480626112;12339.259644421363;12366.876331236752;12373.814392784116;9888.752781180528;10042.748931276776;10088.646897358558;10095.545700443497;10096.495175241356;7299.23358047408;7531.209223031612;7536.0956685198125;7619.961900190575;7667.11828139771;3054.618172728409;3069.64699059611;3104.5498402731478;3117.2830249042845;3125.812451252932;876.9079246679134;878.6880657366671;905.5789058088021;920.7191806498948;945.2674177512483;28198.295042624097;28394.574081388797;28482.287942801595;28721.856390717912;29017.41965160685;937.3813283233034;943.4433684126399;969.5879251318162;972.9124378805941;1017.6794309792392;14680.265986700622;15288.923555382375;15434.691306173814;15440.691186176213;15458.304376303093;124584.37707811584;124764.37617811853;125103;125201;125208.37395812962;42108;43359;43563.78218108889;49017;49297.26054109191;1138.6413279816998;1175.2184797109996;1187.346959172469;1194.940252987347;1198.0894520164911;27987;28993.420131596828;29225;29929.70070299269;29943;42912;43494.565054350314;43507.78246108749;43532.78233608938;43565.78217108894;352778;355637;356059;357634;635566;38082.61917380791;38587;38679.41980870345;38806.80596596999;39216;41257.793711031256;41629.79185104055;41896.3715544261;41928;42030;36173.81913090418;36198;36402.27195456129;36764.34560444733;37332.62667373291;36525.788287725816;37146.6285337154;37439.251214976095;37576;38133.61866381301;35799.28401431905;35999.820000899825;36184.63815361813;36478.27043459169;37039.444408334435;31596.842015789774;33319;33357.33285334231;33817.32365352728;33838.83080584581;24463.26610201697;25577.616335755352;25721.485570288114;26699;26970 09:34:56 INFO - PROCESS | 3387 | |2;jquery.html;328.87831502344136;337.0696876620528;344.8965310406878;352.90824385659727;369.420010583384;12844.871551284485;16022;16432.260548275328;16850.747238791428;17945.91027044866;15755.921220393911;15955.042697438163;15996.040237585725;16081.195940202972;16122.596935076628;4295.699301048928;4883.340748998884;4999.825006124786;5026.673266237683;5071.112555302826;3713.6843368313725;3880.6507414332705;4952.158133117361;5470.8085217017415;5734.827955161351;5783.710814459281;5790.594658373915;5800;5801.738921748511;5805.564582656297;5576.079946808772;5839.503642190419;5853.853653658693;5880.794172203952;5881.617694849821;5096.286519887219;5207.140821764404;5212.061828870802;5212.452692467312;5215.608829337815;20511.89744051285;20818.687719684218;20960.895195523924;21142.365729028155;21173.258935937167;1864.7785700366283;1919.2131226197332;2153;2348.6711860339565;2447.3881529617597;12951.805722914163;13384.330783460886;13391.129576577492;13513.05408621397;13928.651783705387;1702.6509565539159;1752.8597712182996;1756.332593614431;1773.485689150145;1807.8994970878814;69066.65466672635;69816.30183698148;69871.65064174698;70260.29739702589;71155.28844711538;8989.41568798026;9226.953865230631;9251.306152038624;9290.652855335939;9550.570224339921;12686.429110690042;12708.809367859489;12782.936085319514;12793.424295906707;12797.424115914806;6581.341865813476;6876.346747059121;6884.242733299333;6966.651667416609;7037.155541334971;6466.902996455057;6534.7386104556235;6708.631025293558;6725.125733654691;6731.124953755981;5992.221011268507;6017.277926648742;6068.81522651845;6102.7558897644485;6155.938440615626;1578.2503310927218;1589.3721979817908;1669.8079720832018;1677.5088992845615;1695.3472912928364;886.9423487473293;892.7812685891998;908.3232991421434;934.6635211324054;979.4417182206074;15974.36102555908;16919.23863426149;17315.134243287786;17951.281948722168;18206.726899096524;825.3603457320625;898.793277546155;900.4687234531527;904.380499357942;918.2103391083663;9490.525473726286;9866.408015519091;10310.461675125594;10406.219533534864;10535.736606584744;289596;293866;294807;410136;423799;81434.18565814385;85190.14809851946;85390.57304713437;85457.57271213729;86587.56706216554;890.6348397157135;899.8110396816742;923.9907600923905;929.1405449958896;929.4516235421135;15423.845761542241;15603.219839007777;16192.919035405219;16308.347666093223;16561.056600004802;29662.555061674524;39224.41163382609;39288;39360.80319598383;40940.79529602333;53248.46751532435;54164.91712154789;54620.180697290365;56482;56772;7155.892661609976;7160.283971602798;7230.855382892418;7249.710011599477;7326.084239470067;9428.717138485856;10808.243422960632;11681.649550513499;11869.465874035517;11898.22661526998;9727.65953191635;9841.85237221428;10249.33379330371;10537.789244215226;10648.201384896318;9546.093121153479;10156.593736250466;10199.13307368882;10258.794824103326;10345;10157.644482443375;10301.587936482456;10399.896001039893;10447.373157610567;10698.73253168677;7147.428205743632;7252.637368131678;7297.358094428923;7407.8148046299275;7422.480426370318;8246.83506329882;9864.556094975887;10154.644587439405;10363.792724145324;10542.841857371992 09:34:56 INFO - PROCESS | 3387 | |3;mootools.html;1316.8288122544068;1389.4858902206186;1419.8367187773408;1647.7693122962794;1695.220198708594;7406.59263740494;7866.803329916755;7882.881756773653;7890.447668663196;7892.329152022071;6454.806355809334;7509.812254693622;7749;7755.224477552242;7775.30022297993;2166.198506552578;2189.693442917993;2189.868607883524;2193.1008286602496;2196.4728465168405;2181.0839447432118;2197.13213280754;2225.043231410493;2225.521512874732;2229.2866282789514;2200.273909609825;2203.7686042965497;2221.466847956487;2227.5433536125056;2233.519793244452;2183.094015983373;2185;2186.8906554672203;2186.9234576789736;2190.539986602815;2141.4325203821;2163.2104281937136;2163.2212403534713;2172.684960680708;2172.9565408691897;7808.023997000375;7814.687412503493;7874.803129921741;7880.330171935392;7883.921160788376;4324.13517296542;4449.599536041772;4450.020995381044;4452.065066336073;4457.687961842672;2683.6913754918046;2722.7141150179145;2771.625830512875;2782.3044238940265;2782.5408807546733;792.5403266105645;838.8322335532918;848.5460278750838;852.9872051919226;1619.4817658349332;9827.606895724162;10329.84505232422;10331.27681062326;10339.741506462398;10365.533550990223;3789;3963.722539422213;4013.8595149169637;4013.8996525087105;4079.796010199478;8219.95890020546;8298.087210406851;8301.626426810808;8304;8316.459430137143;4370.825166993284;4376.037271800263;4383;4385.978070109692;4394.36281739146;3419.8803041893416;3828.3874580067054;3972.7020473464027;4047.8785636430953;4056.6146216110014;3362.1090411041096;3375.5611770470173;3494.021673931303;3510.578730552299;3519.771214871025;992.7567745902156;1026.630413051301;1033.302520798473;1033.8707661542308;1034.043509753475;765.4756491803132;766.2031487253195;767.2289349204126;778.7975126467046;786.1470304719329;5214.45248248936;5353.464653534693;5388.5419739321815;5588.6646801192055;5598.776048958078;795.6459375577813;796.77690246731;807.5195258820992;866.2377108144792;888.8888888888889;3303.124671961932;3558.252766918976;3599.9280014400088;3622.239329740731;3637.127089498554;9219.308551858638;9628.133467987915;9632.614695412245;9643.614255429704;9643.951780241054;9543.856842147374;9555.569999350046;9583.904160958302;9592.95203523978;9610.135087842127;7074.575525468488;7185.748498802622;7190.209077001526;7193.748218812421;7209.315115064165;5245.895082098413;5323.0684630190335;5383.138697808332;5441.156620723794;5559.388467268516;8390.874136887829;9026.45841249527;9068.50123243228;9077.455352678597;9095.954520227357;8018.358531317597;8261.628226729932;9060.365774395728;9106.408083474553;9155.587998539948;5749.396313387034;6015.097735339734;6572.572782769104;6742.730290788313;6746.4265537429865;6763.729450822108;7071.71713131469;7085.574865508086;7085.6457177141965;7091.078159839188;6295.779647712308;6477.546571739933;6500.804975850732;6595.703193356215;6631.900521492278;6252.218472690914;6297.149884765681;6310.432061114522;6345.90481142774;6402.903956440564;6247.562670613013;6334.366563343813;6339.683015849097;6340.651264180515;6341.8097457076365;4526.751028693454;4536.251518499411;4544.6818722689095;4622.791974361229;4688.906221875612;4580.198465268498;4616.192166370939;4620.353150558857;4685.976570117127;4747.952520474751 09:34:56 INFO - PROCESS | 3387 | |4;prototype.html;295.98919689261174;298.3510863871081;298.3763933379238;299.6314533124257;302.38464724286075;4893.877653058671;4911.189653707139;4924.67989580677;4933.851984440473;4936.160852655048;4855.465898751135;4880.975595122029;4907.705537667743;4922.7538623068795;4937.210046392578;3687.815609219535;3782.2624588205313;3804.6385593368723;3890.9805450972704;3909.335412979786;3851.6697398074043;3853.9381430934454;3860.1893602343544;3863.9613603864022;3881.961180388188;3816.9579275087835;3824.292505886406;3841.6938240998056;3843.2889915365745;3848;3684.189478314753;3722.8696995605023;3849;3872.3029854626157;3879.7866117363533;3390.1694084949345;3397.813120278384;3404.370191514553;3409.7954122752712;3437.2781715839706;4808.230683090724;4811.182099043136;4813.3983252093485;4818.397700287464;4819.204831202847;4317.460317460317;4391.736495810262;4416.646668266563;4430.8449204277695;4433.711808732454;5120.5903527718065;5132.56373208274;5143.7685304161405;5154.201098829687;5163.922541161885;3751.2497500499735;3767.208886133888;3790.336691079078;3790.4314352847296;3800.8289626966853;5311.1767676009895;5397.487238712355;5434.451181413278;5482.342118945752;5484.533814625762;3807.2766174427325;3829.5213098362706;3831.9616803831605;3852.730308878408;3853.344931361675;3900.6099390061336;3913.62820532049;3916.118873253495;3919.353306704362;3926.1166237596885;4417.315316126005;4419.801108950105;4427.158839820424;4441.356003379492;4449.755263460541;5062.82280120194;5099.974500127476;5101.311322971425;5110;5131.204663277198;1295.9567548123662;1307.9209652036918;1308.3981368570373;1310.0960337367187;1311.2001678975817;836.6569706420338;841.7432683031611;868.9522076285865;869.9217070463562;873.2315562305258;4350.412694286294;4490.842820501332;4504.729716216972;4505.662075344297;4509.7970591323465;5185.9740701297005;5228.039485193052;5287.735613219324;5294.49702278283;5321.228421878884;4554.407926969473;4568.680192386568;4569.2689169732685;4576.702514336557;4582.450105987236;2685.7179996100126;2813.4373125375005;2821.830690158597;2829.7124808212216;2829.915102546927;4967.615544538642;4975.651704380731;4979.551840334315;4985.675931064469;4986.601071914238;5194.636375453682;5411.783528658888;5423;5426.538744206787;5441.374241962225;4995.350604421475;5013.373328333958;5016.272640467185;5030.144875371196;5030.3963524377305;5346.919796202982;5347.866303342447;5376.865578360573;5422.902471676612;5427.670220795931;5150.052257004957;5215.13950198213;5215.269862219368;5234.712090835041;5265.078611243094;5016.347874776402;5024.598032157492;5030.170021946338;5033.295338652519;5038.874028149326;3735.9252814944093;3748.4939533162674;3775.0939774453386;3781.3760729479327;3785.734998550075;5109.9233511498105;5333.9466605335;5379.35447746273;5428.83713488596;5450.291462109901;5174.249733788655;5179.974100129475;5181.119209734429;5183.144781111226;5203.8178663746585;5151.793928242828;5173.870653233699;5184.170532714747;5194.805194805243;5233.461771040966;4863.2461968394955;5097.260897169964;5111.105556527518;5125;5129.538341549279;4942.678725882806;5061.886384995295;5216.686998780086;5226.738663066755;5231.42454330031;5074.133114790132;5085.389753229636;5089.7709603067215;5100.260462232881;5101.668391554537 09:34:56 INFO - PROCESS | 3387 | |5;yui.html;598.5361344957657;619.2259675405743;669.4075742967473;715.7924201981425;746.4327111395341;12254.326012069343;12638.684032899158;13165.60503184906;13169.868301316996;13172.20966741995;12754.426050827711;13010.869891301109;13040.543580974669;13040.608781736539;13051.543195988143;632.7595513704786;771.4137255685691;790.0756115345031;792.3186059988406;792.374024520628;642.8457170279123;647.8445173158432;655.2726473614284;655.7442597387;751.7218629107238;819.2012787532168;828.8176601147768;833.2500749325625;833.7665453672981;834.2741814621288;828.8508068547659;829.0134739659816;829.3448175940999;829.5230242610523;829.9917000830005;483.23889873449457;565.047894298109;607.2288193993603;607.4502575169435;607.480604083511;12077.45651445687;12552.121351505399;12573.811392829115;12578.559750408784;12606.054545909003;11489.942550287195;12260.570880019246;12688.429020694091;12883.88015692548;12909.419076141503;11546.53813847445;11656.825147622792;11821.17251792375;11902.761944761143;11990.760184796343;3893.1240470894104;3934.7048971327263;3945.940810887839;3991.381335892941;4018.2365350583295;61869.381306187264;63823;63907.68046159786;64024.679876600785;64975.67512162409;9266.258699304039;9562.187214086742;10080.949595252123;10313.071823535918;10368.429736364573;17099.658006839793;17223.56941076458;17345.392911248047;17390.739138912926;17442.215100320514;6326.49388048955;6458;6482.935170648328;6494.9675251624385;6647.767328143492;3651.9634803652157;3714.23858109087;3733.5893051764283;3755.4366844973474;3773.132179598708;2707.634469346613;2778.6665600128113;2792.3437992071845;2797.0909454426987;2797.8321300722023;497.6242936582857;504.27132793114333;506.72890003847766;511.7134404733361;519.4052809533064;471.8442913838425;525.0575217484625;543.6384804105226;550.5843088468181;566.4165909113619;7106.609136497439;7396.852062958711;7426.331630153312;7475.476716629783;7485.723413601698;505.2623170171591;528.2815371095307;538.5852893272158;543.4998608958296;549.3901769036366;3448.8103154326755;3600.1899572595958;3678.9448158277646;3725.8509659613856;3802.5627052888717;76689.23310766932;77688.61155694185;96709.5164524187;99003;99914.50042749739;68036.319636803;69624;69848;82103;84032;69539.65230173917;71143;72388.63805680937;73223.63388183131;75211;8009.3192078673965;8311.127331630092;8344.87482687748;8460.255312408903;8545.060043395097;31790.36419271648;37508.43737343996;39905;43696.56303436925;44221.778891105336;53594.19608705794;53922.460775391744;56141;56340.15489767575;61463;10986.505607247853;11228.326300422;11365.090792736395;11514.80830178933;11702.180847340604;12567;13108.737825243252;13175.538856140372;13311.800322995357;13328.666783330495;11564.190506664452;11640.126990475579;11677.124215684027;11703.23928944616;11728.472218750007;11236.943815281198;11636.767264654829;11645.47595358194;12064.51741930348;12256.203346782431;11635;11643.650690479299;11869.703257418634;11969.401529923294;12468.189567678071;9468.337216394786;9704.320697551386;10016.599336026477;10357.22320825926;10732.946335268274;9344.626214951326;9763.267754918552;9803.215742740422;9897.455639939872;9934.900650993686 09:34:56 INFO - PROCESS | 3387 | __end_tp_report 09:34:56 INFO - PROCESS | 3387 | __start_cc_report 09:34:56 INFO - PROCESS | 3387 | _x_x_mozilla_cycle_collect,1195 09:34:56 INFO - PROCESS | 3387 | __end_cc_report 09:34:56 INFO - PROCESS | 3387 | __startTimestamp1469637296025__endTimestamp 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | ------- Summary: start ------- 09:34:56 INFO - PROCESS | 3387 | Number of tests: 6 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#0] dojo.html Cycles:165 Average:4732.65 Median:4832.32 stddev:490.01 (10.1%) stddev-sans-first:462.60 09:34:56 INFO - PROCESS | 3387 | Values: 2618.9 2626.0 2647.5 2660.5 2661.4 4693.9 4727.6 4771.4 4782.6 4805.9 4753.6 4787.4 4813.1 4819.4 4829.2 4322.1 4336.6 4358.6 4377.7 4446.7 4402.5 4429.6 4487.5 4518.5 4533.5 4435.7 4482.4 4483.4 4490.3 4529.4 4264.8 4321.8 4328.5 4377.2 4389.6 4307.5 4330.6 4350.2 4414.4 4446.0 4787.2 4812.9 4823.8 4824.7 4834.7 4951.3 5154.7 5161.9 5167.0 5173.8 5029.2 5050.9 5101.6 5125.9 5177.8 4789.5 4813.1 4820.5 4823.8 4828.5 5121.6 5207.0 5266.0 5271.9 5273.5 4986.7 5055.6 5066.6 5076.2 5081.5 5113.1 5129.2 5163.3 5176.3 5183.3 5000.7 5036.4 5064.3 5069.6 5126.8 5050.0 5074.7 5084.0 5131.2 5134.1 4416.2 4424.9 4425.3 4427.8 4473.4 3838.7 3859.4 3883.7 3887.5 3919.7 4356.0 4369.1 4395.6 4423.1 4495.9 5145.8 5153.4 5154.6 5168.3 5212.7 4437.9 4444.2 4449.5 4453.3 4491.3 4532.8 4586.9 4602.8 4622.1 4679.9 4768.4 4778.9 4788.3 4788.3 4832.3 5103.5 5107.5 5108.3 5114.6 5118.6 4637.8 4772.5 4791.1 4802.6 4879.0 5041.0 5044.4 5060.7 5066.6 5116.9 5124.2 5132.8 5145.0 5146.5 5148.4 4863.2 4935.3 4959.7 4972.0 5019.2 4976.1 4977.6 4981.5 4988.0 4991.2 4891.2 4901.4 4939.4 4951.0 4956.6 4838.8 4904.0 4929.3 4936.0 4943.9 4887.6 4898.9 4899.0 4901.5 4934.7 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#1] ext.html Cycles:180 Average:41672.51 Median:196716.64 stddev:77898.73 (39.6%) stddev-sans-first:78056.03 09:34:56 INFO - PROCESS | 3387 | Values: 539.3 570.6 579.5 591.3 596.4 28637.3 38130.6 39278.4 39405.0 43600.6 40682.4 41066.6 41068.2 41167.0 41169.6 7283.1 7662.7 7802.8 7808.3 7818.8 7291.5 7493.4 7509.1 9654.4 9882.1 10016.2 10048.7 10075.2 10080.1 10090.0 9845.6 9902.2 9918.2 9986.1 9994.4 10016.9 10087.0 10088.4 10092.8 10102.8 37247.8 37659.8 37712.0 37717.6 37802.8 2817.0 2893.2 3001.5 3066.5 3627.4 28515.3 28601.0 29097.6 29418.3 29481.1 3260.9 3269.4 3297.6 3331.9 3343.0 238323.0 239995.0 241206.0 241449.0 242778.8 28734.3 29741.7 54270.5 54587.0 54701.5 32135.2 32251.4 32307.7 32404.2 32483.0 12201.3 12250.4 12339.3 12366.9 12373.8 9888.8 10042.7 10088.6 10095.5 10096.5 7299.2 7531.2 7536.1 7620.0 7667.1 3054.6 3069.6 3104.5 3117.3 3125.8 876.9 878.7 905.6 920.7 945.3 28198.3 28394.6 28482.3 28721.9 29017.4 937.4 943.4 969.6 972.9 1017.7 14680.3 15288.9 15434.7 15440.7 15458.3 124584.4 124764.4 125103.0 125201.0 125208.4 42108.0 43359.0 43563.8 49017.0 49297.3 1138.6 1175.2 1187.3 1194.9 1198.1 27987.0 28993.4 29225.0 29929.7 29943.0 42912.0 43494.6 43507.8 43532.8 43565.8 352778.0 355637.0 356059.0 357634.0 635566.0 38082.6 38587.0 38679.4 38806.8 39216.0 41257.8 41629.8 41896.4 41928.0 42030.0 36173.8 36198.0 36402.3 36764.3 37332.6 36525.8 37146.6 37439.3 37576.0 38133.6 35799.3 35999.8 36184.6 36478.3 37039.4 31596.8 33319.0 33357.3 33817.3 33838.8 24463.3 25577.6 25721.5 26699.0 26970.0 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#2] jquery.html Cycles:180 Average:23405.98 Median:4917.75 stddev:58089.92 (1181.2%) stddev-sans-first:58227.03 09:34:56 INFO - PROCESS | 3387 | Values: 328.9 337.1 344.9 352.9 369.4 12844.9 16022.0 16432.3 16850.7 17945.9 15755.9 15955.0 15996.0 16081.2 16122.6 4295.7 4883.3 4999.8 5026.7 5071.1 3713.7 3880.7 4952.2 5470.8 5734.8 5783.7 5790.6 5800.0 5801.7 5805.6 5576.1 5839.5 5853.9 5880.8 5881.6 5096.3 5207.1 5212.1 5212.5 5215.6 20511.9 20818.7 20960.9 21142.4 21173.3 1864.8 1919.2 2153.0 2348.7 2447.4 12951.8 13384.3 13391.1 13513.1 13928.7 1702.7 1752.9 1756.3 1773.5 1807.9 69066.7 69816.3 69871.7 70260.3 71155.3 8989.4 9227.0 9251.3 9290.7 9550.6 12686.4 12708.8 12782.9 12793.4 12797.4 6581.3 6876.3 6884.2 6966.7 7037.2 6466.9 6534.7 6708.6 6725.1 6731.1 5992.2 6017.3 6068.8 6102.8 6155.9 1578.3 1589.4 1669.8 1677.5 1695.3 886.9 892.8 908.3 934.7 979.4 15974.4 16919.2 17315.1 17951.3 18206.7 825.4 898.8 900.5 904.4 918.2 9490.5 9866.4 10310.5 10406.2 10535.7 289596.0 293866.0 294807.0 410136.0 423799.0 81434.2 85190.1 85390.6 85457.6 86587.6 890.6 899.8 924.0 929.1 929.5 15423.8 15603.2 16192.9 16308.3 16561.1 29662.6 39224.4 39288.0 39360.8 40940.8 53248.5 54164.9 54620.2 56482.0 56772.0 7155.9 7160.3 7230.9 7249.7 7326.1 9428.7 10808.2 11681.6 11869.5 11898.2 9727.7 9841.9 10249.3 10537.8 10648.2 9546.1 10156.6 10199.1 10258.8 10345.0 10157.6 10301.6 10399.9 10447.4 10698.7 7147.4 7252.6 7297.4 7407.8 7422.5 8246.8 9864.6 10154.6 10363.8 10542.8 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#3] mootools.html Cycles:180 Average:5017.20 Median:5500.27 stddev:2800.43 (50.9%) stddev-sans-first:2794.48 09:34:56 INFO - PROCESS | 3387 | Values: 1316.8 1389.5 1419.8 1647.8 1695.2 7406.6 7866.8 7882.9 7890.4 7892.3 6454.8 7509.8 7749.0 7755.2 7775.3 2166.2 2189.7 2189.9 2193.1 2196.5 2181.1 2197.1 2225.0 2225.5 2229.3 2200.3 2203.8 2221.5 2227.5 2233.5 2183.1 2185.0 2186.9 2186.9 2190.5 2141.4 2163.2 2163.2 2172.7 2173.0 7808.0 7814.7 7874.8 7880.3 7883.9 4324.1 4449.6 4450.0 4452.1 4457.7 2683.7 2722.7 2771.6 2782.3 2782.5 792.5 838.8 848.5 853.0 1619.5 9827.6 10329.8 10331.3 10339.7 10365.5 3789.0 3963.7 4013.9 4013.9 4079.8 8220.0 8298.1 8301.6 8304.0 8316.5 4370.8 4376.0 4383.0 4386.0 4394.4 3419.9 3828.4 3972.7 4047.9 4056.6 3362.1 3375.6 3494.0 3510.6 3519.8 992.8 1026.6 1033.3 1033.9 1034.0 765.5 766.2 767.2 778.8 786.1 5214.5 5353.5 5388.5 5588.7 5598.8 795.6 796.8 807.5 866.2 888.9 3303.1 3558.3 3599.9 3622.2 3637.1 9219.3 9628.1 9632.6 9643.6 9644.0 9543.9 9555.6 9583.9 9593.0 9610.1 7074.6 7185.7 7190.2 7193.7 7209.3 5245.9 5323.1 5383.1 5441.2 5559.4 8390.9 9026.5 9068.5 9077.5 9096.0 8018.4 8261.6 9060.4 9106.4 9155.6 5749.4 6015.1 6572.6 6742.7 6746.4 6763.7 7071.7 7085.6 7085.6 7091.1 6295.8 6477.5 6500.8 6595.7 6631.9 6252.2 6297.1 6310.4 6345.9 6402.9 6247.6 6334.4 6339.7 6340.7 6341.8 4526.8 4536.3 4544.7 4622.8 4688.9 4580.2 4616.2 4620.4 4686.0 4748.0 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#4] prototype.html Cycles:180 Average:4297.83 Median:4916.97 stddev:1247.28 (25.4%) stddev-sans-first:1214.08 09:34:56 INFO - PROCESS | 3387 | Values: 296.0 298.4 298.4 299.6 302.4 4893.9 4911.2 4924.7 4933.9 4936.2 4855.5 4881.0 4907.7 4922.8 4937.2 3687.8 3782.3 3804.6 3891.0 3909.3 3851.7 3853.9 3860.2 3864.0 3882.0 3817.0 3824.3 3841.7 3843.3 3848.0 3684.2 3722.9 3849.0 3872.3 3879.8 3390.2 3397.8 3404.4 3409.8 3437.3 4808.2 4811.2 4813.4 4818.4 4819.2 4317.5 4391.7 4416.6 4430.8 4433.7 5120.6 5132.6 5143.8 5154.2 5163.9 3751.2 3767.2 3790.3 3790.4 3800.8 5311.2 5397.5 5434.5 5482.3 5484.5 3807.3 3829.5 3832.0 3852.7 3853.3 3900.6 3913.6 3916.1 3919.4 3926.1 4417.3 4419.8 4427.2 4441.4 4449.8 5062.8 5100.0 5101.3 5110.0 5131.2 1296.0 1307.9 1308.4 1310.1 1311.2 836.7 841.7 869.0 869.9 873.2 4350.4 4490.8 4504.7 4505.7 4509.8 5186.0 5228.0 5287.7 5294.5 5321.2 4554.4 4568.7 4569.3 4576.7 4582.5 2685.7 2813.4 2821.8 2829.7 2829.9 4967.6 4975.7 4979.6 4985.7 4986.6 5194.6 5411.8 5423.0 5426.5 5441.4 4995.4 5013.4 5016.3 5030.1 5030.4 5346.9 5347.9 5376.9 5422.9 5427.7 5150.1 5215.1 5215.3 5234.7 5265.1 5016.3 5024.6 5030.2 5033.3 5038.9 3735.9 3748.5 3775.1 3781.4 3785.7 5109.9 5333.9 5379.4 5428.8 5450.3 5174.2 5180.0 5181.1 5183.1 5203.8 5151.8 5173.9 5184.2 5194.8 5233.5 4863.2 5097.3 5111.1 5125.0 5129.5 4942.7 5061.9 5216.7 5226.7 5231.4 5074.1 5085.4 5089.8 5100.3 5101.7 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - PROCESS | 3387 | [#5] yui.html Cycles:180 Average:16890.79 Median:506.00 stddev:23595.95 (4663.3%) stddev-sans-first:23630.43 09:34:56 INFO - PROCESS | 3387 | Values: 598.5 619.2 669.4 715.8 746.4 12254.3 12638.7 13165.6 13169.9 13172.2 12754.4 13010.9 13040.5 13040.6 13051.5 632.8 771.4 790.1 792.3 792.4 642.8 647.8 655.3 655.7 751.7 819.2 828.8 833.3 833.8 834.3 828.9 829.0 829.3 829.5 830.0 483.2 565.0 607.2 607.5 607.5 12077.5 12552.1 12573.8 12578.6 12606.1 11489.9 12260.6 12688.4 12883.9 12909.4 11546.5 11656.8 11821.2 11902.8 11990.8 3893.1 3934.7 3945.9 3991.4 4018.2 61869.4 63823.0 63907.7 64024.7 64975.7 9266.3 9562.2 10080.9 10313.1 10368.4 17099.7 17223.6 17345.4 17390.7 17442.2 6326.5 6458.0 6482.9 6495.0 6647.8 3652.0 3714.2 3733.6 3755.4 3773.1 2707.6 2778.7 2792.3 2797.1 2797.8 497.6 504.3 506.7 511.7 519.4 471.8 525.1 543.6 550.6 566.4 7106.6 7396.9 7426.3 7475.5 7485.7 505.3 528.3 538.6 543.5 549.4 3448.8 3600.2 3678.9 3725.9 3802.6 76689.2 77688.6 96709.5 99003.0 99914.5 68036.3 69624.0 69848.0 82103.0 84032.0 69539.7 71143.0 72388.6 73223.6 75211.0 8009.3 8311.1 8344.9 8460.3 8545.1 31790.4 37508.4 39905.0 43696.6 44221.8 53594.2 53922.5 56141.0 56340.2 61463.0 10986.5 11228.3 11365.1 11514.8 11702.2 12567.0 13108.7 13175.5 13311.8 13328.7 11564.2 11640.1 11677.1 11703.2 11728.5 11236.9 11636.8 11645.5 12064.5 12256.2 11635.0 11643.7 11869.7 11969.4 12468.2 9468.3 9704.3 10016.6 10357.2 10732.9 9344.6 9763.3 9803.2 9897.5 9934.9 09:34:56 INFO - PROCESS | 3387 | -------- Summary: end -------- 09:34:56 INFO - PROCESS | 3387 | 09:34:56 INFO - TEST-INFO | 3387: exit 0 09:34:56 INFO - TEST-OK | dromaeo_css | took 1123036ms 09:34:56 INFO - TEST-START | kraken 09:34:56 INFO - operating with platform_type : linux_ 09:34:56 INFO - Initialising browser for kraken test... 09:34:56 INFO - TEST-INFO | started process 3571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdLSxC/profile http://localhost:36871/getInfo.html) 09:35:00 INFO - PROCESS | 3571 | JavaScript error: , line 0: uncaught exception: undefined 09:35:01 INFO - PROCESS | 3571 | __metrics Screen width/height:1600/1200 09:35:01 INFO - PROCESS | 3571 | colorDepth:24 09:35:01 INFO - PROCESS | 3571 | Browser inner width/height: 1024/697 09:35:01 INFO - PROCESS | 3571 | __metrics 09:35:01 INFO - PROCESS | 3571 | 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" 09:35:01 INFO - PROCESS | 3571 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:02 INFO - TEST-INFO | 3571: exit 0 09:35:02 INFO - Browser initialized. 09:35:02 INFO - Running cycle 1/1 for kraken test... 09:35:02 INFO - TEST-INFO | started process 3653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdLSxC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:14 INFO - PROCESS | 3653 | RSS: Main: 159424512 09:35:14 INFO - PROCESS | 3653 | 09:35:17 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:18 INFO - PROCESS | 3653 | RSS: Main: 215277568 09:35:18 INFO - PROCESS | 3653 | 09:35:21 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-dft) 09:35:21 INFO - PROCESS | 3653 | RSS: Main: 193167360 09:35:21 INFO - PROCESS | 3653 | 09:35:25 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-fft) 09:35:25 INFO - PROCESS | 3653 | RSS: Main: 271994880 09:35:25 INFO - PROCESS | 3653 | 09:35:27 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36871/tests/kraken/driver.html?testName=audio-oscillator) 09:35:28 INFO - PROCESS | 3653 | RSS: Main: 182947840 09:35:28 INFO - PROCESS | 3653 | 09:35:30 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:31 INFO - PROCESS | 3653 | RSS: Main: 186912768 09:35:31 INFO - PROCESS | 3653 | 09:35:34 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:35 INFO - PROCESS | 3653 | RSS: Main: 223576064 09:35:35 INFO - PROCESS | 3653 | 09:35:38 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36871/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:39 INFO - PROCESS | 3653 | RSS: Main: 216788992 09:35:39 INFO - PROCESS | 3653 | 09:35:42 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36871/tests/kraken/driver.html?testName=json-parse-financial) 09:35:42 INFO - PROCESS | 3653 | RSS: Main: 219955200 09:35:42 INFO - PROCESS | 3653 | 09:35:44 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:44 INFO - PROCESS | 3653 | RSS: Main: 186048512 09:35:44 INFO - PROCESS | 3653 | 09:35:46 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:47 INFO - PROCESS | 3653 | RSS: Main: 191672320 09:35:47 INFO - PROCESS | 3653 | 09:35:49 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:50 INFO - PROCESS | 3653 | RSS: Main: 195579904 09:35:50 INFO - PROCESS | 3653 | 09:35:53 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:53 INFO - PROCESS | 3653 | RSS: Main: 190689280 09:35:53 INFO - PROCESS | 3653 | 09:35:56 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:57 INFO - PROCESS | 3653 | RSS: Main: 193576960 09:35:57 INFO - PROCESS | 3653 | 09:35:58 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:36871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36871/tests/kraken/driver.html?testName=ai-astar) 09:35:59 INFO - PROCESS | 3653 | RSS: Main: 245080064 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | __start_tp_report 09:35:59 INFO - PROCESS | 3653 | _x_x_mozilla_page_load 09:35:59 INFO - PROCESS | 3653 | _x_x_mozilla_page_load_details 09:35:59 INFO - PROCESS | 3653 | |i|pagename|runs| 09:35:59 INFO - PROCESS | 3653 | |0;ai-astar;104;114;113;112;112;113;112;114;115;112 09:35:59 INFO - PROCESS | 3653 | |1;audio-beat-detection;144;121;124;202;124;130;147;126;157;130 09:35:59 INFO - PROCESS | 3653 | |2;audio-dft;160;170;160;159;161;160;162;162;161;160 09:35:59 INFO - PROCESS | 3653 | |3;audio-fft;75;76;76;119;75;76;75;75;102;75 09:35:59 INFO - PROCESS | 3653 | |4;audio-oscillator;85;85;119;86;84;87;129;85;85;126 09:35:59 INFO - PROCESS | 3653 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 09:35:59 INFO - PROCESS | 3653 | |6;imaging-darkroom;146;146;147;147;146;147;146;147;146;146 09:35:59 INFO - PROCESS | 3653 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;96;95 09:35:59 INFO - PROCESS | 3653 | |8;json-parse-financial;63;61;61;61;62;63;61;61;62;61 09:35:59 INFO - PROCESS | 3653 | |9;json-stringify-tinderbox;66;66;66;67;67;65;68;70;66;67 09:35:59 INFO - PROCESS | 3653 | |10;stanford-crypto-aes;80;79;80;85;80;89;78;80;80;81 09:35:59 INFO - PROCESS | 3653 | |11;stanford-crypto-ccm;139;142;128;137;133;128;129;127;184;131 09:35:59 INFO - PROCESS | 3653 | |12;stanford-crypto-pbkdf2;173;178;165;167;166;165;167;164;165;164 09:35:59 INFO - PROCESS | 3653 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;74;67;67;67;66 09:35:59 INFO - PROCESS | 3653 | __end_tp_report 09:35:59 INFO - PROCESS | 3653 | __start_cc_report 09:35:59 INFO - PROCESS | 3653 | _x_x_mozilla_cycle_collect,1930 09:35:59 INFO - PROCESS | 3653 | __end_cc_report 09:35:59 INFO - PROCESS | 3653 | __startTimestamp1469637359235__endTimestamp 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | ------- Summary: start ------- 09:35:59 INFO - PROCESS | 3653 | Number of tests: 14 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.03 (2.7%) stddev-sans-first:1.12 09:35:59 INFO - PROCESS | 3653 | Values: 104.0 114.0 113.0 112.0 112.0 113.0 112.0 114.0 115.0 112.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:137.00 stddev:24.64 (18.0%) stddev-sans-first:26.10 09:35:59 INFO - PROCESS | 3653 | Values: 144.0 121.0 124.0 202.0 124.0 130.0 147.0 126.0 157.0 130.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:3.14 (1.9%) stddev-sans-first:3.28 09:35:59 INFO - PROCESS | 3653 | Values: 160.0 170.0 160.0 159.0 161.0 160.0 162.0 162.0 161.0 160.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.35 (20.5%) stddev-sans-first:16.05 09:35:59 INFO - PROCESS | 3653 | Values: 75.0 76.0 76.0 119.0 75.0 76.0 75.0 75.0 102.0 75.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:85.00 stddev:19.19 (22.6%) stddev-sans-first:19.85 09:35:59 INFO - PROCESS | 3653 | Values: 85.0 85.0 119.0 86.0 84.0 87.0 129.0 85.0 85.0 126.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:35:59 INFO - PROCESS | 3653 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:35:59 INFO - PROCESS | 3653 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:35:59 INFO - PROCESS | 3653 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 09:35:59 INFO - PROCESS | 3653 | Values: 63.0 61.0 61.0 61.0 62.0 63.0 61.0 61.0 62.0 61.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.45 09:35:59 INFO - PROCESS | 3653 | Values: 66.0 66.0 66.0 67.0 67.0 65.0 68.0 70.0 66.0 67.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.29 (4.1%) stddev-sans-first:3.46 09:35:59 INFO - PROCESS | 3653 | Values: 80.0 79.0 80.0 85.0 80.0 89.0 78.0 80.0 80.0 81.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:135.00 stddev:17.03 (12.6%) stddev-sans-first:18.06 09:35:59 INFO - PROCESS | 3653 | Values: 139.0 142.0 128.0 137.0 133.0 128.0 129.0 127.0 184.0 131.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:166.50 stddev:4.55 (2.7%) stddev-sans-first:4.35 09:35:59 INFO - PROCESS | 3653 | Values: 173.0 178.0 165.0 167.0 166.0 165.0 167.0 164.0 165.0 164.0 09:35:59 INFO - PROCESS | 3653 | 09:35:59 INFO - PROCESS | 3653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.25 (3.4%) stddev-sans-first:2.39 09:35:59 INFO - PROCESS | 3653 | Values: 68.0 68.0 67.0 67.0 67.0 74.0 67.0 67.0 67.0 66.0 09:35:59 INFO - PROCESS | 3653 | -------- Summary: end -------- 09:35:59 INFO - PROCESS | 3653 | 09:36:00 INFO - TEST-INFO | 3653: exit 0 09:36:00 INFO - TEST-OK | kraken | took 63532ms 09:36:00 INFO - SUITE-END | took 1186s 09:36:00 INFO - Completed test suite (00:19:46) 09:36:00 INFO - javascript benchmark 09:36:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.92143235703, 2625.973740262597, 2647.5499165141923, 2660.454606805604, 2661.401184733435, 4693.882652933678, 4727.598154156896, 4771.427428708551, 4782.593479554233, 4805.927911081332, 4753.572178503934, 4787.40157480315, 4813.109574728669, 4819.397575303087, 4829.227323628212, 4322.13557288542, 4336.566343365654, 4358.6077253047215, 4377.6935614507, 4446.688731788776, 4402.537733537981, 4429.557044295577, 4487.483939346968, 4518.480374756896, 4533.455985281771, 4435.733855968652, 4482.394876691637, 4483.39474170986, 4490.304002879542, 4529.433820772403, 4264.786760661986, 4321.783910804447, 4328.5022222444195, 4377.190219809346, 4389.604935555815, 4307.483102027777, 4330.610245077958, 4350.15172041452, 4414.426124603781, 4445.955540444586, 4787.186178349689, 4812.855614331575, 4823.807047718087, 4824.662273640846, 4834.709917404967, 4951.306817045616, 5154.742262886841, 5161.896762064737, 5167.044096842059, 5173.767180476888, 5029.245613158019, 5050.9494905051215, 5101.591872650216, 5125.897482050338, 5177.8187763428095, 4789.473157952622, 4813.109574728686, 4820.517948205152, 4823.782929768169, 4828.493008234155, 5121.641485096007, 5206.97396513015, 5266.0257852297445, 5271.868203294948, 5273.499017593399, 4986.6758660687665, 5055.570276526463, 5066.569341605931, 5076.213186956028, 5081.4918508148885, 5113.054084994214, 5129.230615407719, 5163.251328557338, 5176.327077479904, 5183.300254465599, 5000.699958002531, 5036.420811606639, 5064.34163558735, 5069.619778516626, 5126.846194614168, 5050.0, 5074.695518268842, 5084.0, 5131.153359695683, 5134.101532231844, 4416.183006143874, 4424.911501769947, 4425.269830477935, 4427.787843439007, 4473.3960915276675, 3838.7120965927666, 3859.4017927221325, 3883.650471457526, 3887.5140607424073, 3919.6668283195677, 4355.956440435619, 4369.104333611602, 4395.582419670126, 4423.07115505741, 4495.887602809956, 5145.819896303611, 5153.3815942087185, 5154.639175257771, 5168.302279192261, 5212.739363031833, 4437.866863994085, 4444.2222611042935, 4449.510553839075, 4453.265211240174, 4491.303847903515, 4532.750698711537, 4586.931196032062, 4602.815887364468, 4622.098690755338, 4679.883002924954, 4768.403949506312, 4778.904421911612, 4788.281757736368, 4788.3056956741775, 4832.323474713613, 5103.464136265638, 5107.514786095315, 5108.28484012246, 5114.590832733298, 5118.616103792156, 4637.837675681335, 4772.475027747015, 4791.065742180242, 4802.639802014793, 4879.048585525788, 5041.0, 5044.369453818273, 5060.721660308718, 5066.645334826527, 5116.948830511647, 5124.231365295235, 5132.820351287687, 5145.022445735298, 5146.536811686966, 5148.382194136728, 4863.2461968394955, 4935.284383764406, 4959.677620954626, 4971.975140124277, 5019.196928491424, 4976.104301225814, 4977.552020318189, 4981.501849815135, 4987.977464619817, 4991.176455884884, 4891.1685013548495, 4901.436334821398, 4939.382577177853, 4950.975245123751, 4956.628252881121, 4838.830640927551, 4903.970166265124, 4929.260610908393, 4935.98812243482, 4943.901121977612, 4887.59812861785, 4898.877528061685, 4899.020195960751, 4901.460839307744, 4934.679245849152], "value": 4701.303591618001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3195631418392, 570.6347937320113, 579.4611011759063, 591.2668291318764, 596.3738075021228, 28637.284067898312, 38130.618693813056, 39278.41082383763, 39405.0, 43600.56399436013, 40682.38976415356, 41066.58933410673, 41068.17863642733, 41167.0, 41169.58830411695, 7283.053203083592, 7662.693492260317, 7802.765917022499, 7808.297253247207, 7818.843623127534, 7291.4895957283015, 7493.363064139555, 7509.098908131032, 9654.372465789736, 9882.110610045094, 10016.198704103654, 10048.743907011623, 10075.19398448126, 10080.143187829044, 10090.041446062613, 9845.60617575296, 9902.158316543031, 9918.156956658693, 9986.051325124101, 9994.400335979792, 10016.89983100167, 10087.04173103554, 10088.445135517544, 10092.848607270824, 10102.848457273147, 37247.81376093102, 37659.811700941595, 37712.0, 37717.62282377196, 37802.81098594517, 2816.985915070432, 2893.23329317731, 3001.5497675348656, 3066.5246886732593, 3627.437747149196, 28515.287117822012, 28601.0, 29097.563536546968, 29418.264543386373, 29481.115566533037, 3260.8695652173883, 3269.362474317509, 3297.554830097954, 3331.8667253309836, 3343.030521148864, 238323.0, 239995.0, 241206.0, 241449.0, 242778.7861060701, 28734.281642958675, 29741.702582974325, 54270.45729542654, 54587.0, 54701.45298547043, 32135.196620084684, 32251.35497290088, 32307.676923230465, 32404.189895252806, 32483.0, 12201.328926908927, 12250.387480626112, 12339.259644421363, 12366.876331236752, 12373.814392784116, 9888.752781180528, 10042.748931276776, 10088.646897358558, 10095.545700443497, 10096.495175241356, 7299.23358047408, 7531.209223031612, 7536.0956685198125, 7619.961900190575, 7667.11828139771, 3054.618172728409, 3069.64699059611, 3104.5498402731478, 3117.2830249042845, 3125.812451252932, 876.9079246679134, 878.6880657366671, 905.5789058088021, 920.7191806498948, 945.2674177512483, 28198.295042624097, 28394.574081388797, 28482.287942801595, 28721.856390717912, 29017.41965160685, 937.3813283233034, 943.4433684126399, 969.5879251318162, 972.9124378805941, 1017.6794309792392, 14680.265986700622, 15288.923555382375, 15434.691306173814, 15440.691186176213, 15458.304376303093, 124584.37707811584, 124764.37617811853, 125103.0, 125201.0, 125208.37395812962, 42108.0, 43359.0, 43563.78218108889, 49017.0, 49297.26054109191, 1138.6413279816998, 1175.2184797109996, 1187.346959172469, 1194.940252987347, 1198.0894520164911, 27987.0, 28993.420131596828, 29225.0, 29929.70070299269, 29943.0, 42912.0, 43494.565054350314, 43507.78246108749, 43532.78233608938, 43565.78217108894, 352778.0, 355637.0, 356059.0, 357634.0, 635566.0, 38082.61917380791, 38587.0, 38679.41980870345, 38806.80596596999, 39216.0, 41257.793711031256, 41629.79185104055, 41896.3715544261, 41928.0, 42030.0, 36173.81913090418, 36198.0, 36402.27195456129, 36764.34560444733, 37332.62667373291, 36525.788287725816, 37146.6285337154, 37439.251214976095, 37576.0, 38133.61866381301, 35799.28401431905, 35999.820000899825, 36184.63815361813, 36478.27043459169, 37039.444408334435, 31596.842015789774, 33319.0, 33357.33285334231, 33817.32365352728, 33838.83080584581, 24463.26610201697, 25577.616335755352, 25721.485570288114, 26699.0, 26970.0], "value": 16437.521109703488, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.87831502344136, 337.0696876620528, 344.8965310406878, 352.90824385659727, 369.420010583384, 12844.871551284485, 16022.0, 16432.260548275328, 16850.747238791428, 17945.91027044866, 15755.921220393911, 15955.042697438163, 15996.040237585725, 16081.195940202972, 16122.596935076628, 4295.699301048928, 4883.340748998884, 4999.825006124786, 5026.673266237683, 5071.112555302826, 3713.6843368313725, 3880.6507414332705, 4952.158133117361, 5470.8085217017415, 5734.827955161351, 5783.710814459281, 5790.594658373915, 5800.0, 5801.738921748511, 5805.564582656297, 5576.079946808772, 5839.503642190419, 5853.853653658693, 5880.794172203952, 5881.617694849821, 5096.286519887219, 5207.140821764404, 5212.061828870802, 5212.452692467312, 5215.608829337815, 20511.89744051285, 20818.687719684218, 20960.895195523924, 21142.365729028155, 21173.258935937167, 1864.7785700366283, 1919.2131226197332, 2153.0, 2348.6711860339565, 2447.3881529617597, 12951.805722914163, 13384.330783460886, 13391.129576577492, 13513.05408621397, 13928.651783705387, 1702.6509565539159, 1752.8597712182996, 1756.332593614431, 1773.485689150145, 1807.8994970878814, 69066.65466672635, 69816.30183698148, 69871.65064174698, 70260.29739702589, 71155.28844711538, 8989.41568798026, 9226.953865230631, 9251.306152038624, 9290.652855335939, 9550.570224339921, 12686.429110690042, 12708.809367859489, 12782.936085319514, 12793.424295906707, 12797.424115914806, 6581.341865813476, 6876.346747059121, 6884.242733299333, 6966.651667416609, 7037.155541334971, 6466.902996455057, 6534.7386104556235, 6708.631025293558, 6725.125733654691, 6731.124953755981, 5992.221011268507, 6017.277926648742, 6068.81522651845, 6102.7558897644485, 6155.938440615626, 1578.2503310927218, 1589.3721979817908, 1669.8079720832018, 1677.5088992845615, 1695.3472912928364, 886.9423487473293, 892.7812685891998, 908.3232991421434, 934.6635211324054, 979.4417182206074, 15974.36102555908, 16919.23863426149, 17315.134243287786, 17951.281948722168, 18206.726899096524, 825.3603457320625, 898.793277546155, 900.4687234531527, 904.380499357942, 918.2103391083663, 9490.525473726286, 9866.408015519091, 10310.461675125594, 10406.219533534864, 10535.736606584744, 289596.0, 293866.0, 294807.0, 410136.0, 423799.0, 81434.18565814385, 85190.14809851946, 85390.57304713437, 85457.57271213729, 86587.56706216554, 890.6348397157135, 899.8110396816742, 923.9907600923905, 929.1405449958896, 929.4516235421135, 15423.845761542241, 15603.219839007777, 16192.919035405219, 16308.347666093223, 16561.056600004802, 29662.555061674524, 39224.41163382609, 39288.0, 39360.80319598383, 40940.79529602333, 53248.46751532435, 54164.91712154789, 54620.180697290365, 56482.0, 56772.0, 7155.892661609976, 7160.283971602798, 7230.855382892418, 7249.710011599477, 7326.084239470067, 9428.717138485856, 10808.243422960632, 11681.649550513499, 11869.465874035517, 11898.22661526998, 9727.65953191635, 9841.85237221428, 10249.33379330371, 10537.789244215226, 10648.201384896318, 9546.093121153479, 10156.593736250466, 10199.13307368882, 10258.794824103326, 10345.0, 10157.644482443375, 10301.587936482456, 10399.896001039893, 10447.373157610567, 10698.73253168677, 7147.428205743632, 7252.637368131678, 7297.358094428923, 7407.8148046299275, 7422.480426370318, 8246.83506329882, 9864.556094975887, 10154.644587439405, 10363.792724145324, 10542.841857371992], "value": 8280.581876241637, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.8288122544068, 1389.4858902206186, 1419.8367187773408, 1647.7693122962794, 1695.220198708594, 7406.59263740494, 7866.803329916755, 7882.881756773653, 7890.447668663196, 7892.329152022071, 6454.806355809334, 7509.812254693622, 7749.0, 7755.224477552242, 7775.30022297993, 2166.198506552578, 2189.693442917993, 2189.868607883524, 2193.1008286602496, 2196.4728465168405, 2181.0839447432118, 2197.13213280754, 2225.043231410493, 2225.521512874732, 2229.2866282789514, 2200.273909609825, 2203.7686042965497, 2221.466847956487, 2227.5433536125056, 2233.519793244452, 2183.094015983373, 2185.0, 2186.8906554672203, 2186.9234576789736, 2190.539986602815, 2141.4325203821, 2163.2104281937136, 2163.2212403534713, 2172.684960680708, 2172.9565408691897, 7808.023997000375, 7814.687412503493, 7874.803129921741, 7880.330171935392, 7883.921160788376, 4324.13517296542, 4449.599536041772, 4450.020995381044, 4452.065066336073, 4457.687961842672, 2683.6913754918046, 2722.7141150179145, 2771.625830512875, 2782.3044238940265, 2782.5408807546733, 792.5403266105645, 838.8322335532918, 848.5460278750838, 852.9872051919226, 1619.4817658349332, 9827.606895724162, 10329.84505232422, 10331.27681062326, 10339.741506462398, 10365.533550990223, 3789.0, 3963.722539422213, 4013.8595149169637, 4013.8996525087105, 4079.796010199478, 8219.95890020546, 8298.087210406851, 8301.626426810808, 8304.0, 8316.459430137143, 4370.825166993284, 4376.037271800263, 4383.0, 4385.978070109692, 4394.36281739146, 3419.8803041893416, 3828.3874580067054, 3972.7020473464027, 4047.8785636430953, 4056.6146216110014, 3362.1090411041096, 3375.5611770470173, 3494.021673931303, 3510.578730552299, 3519.771214871025, 992.7567745902156, 1026.630413051301, 1033.302520798473, 1033.8707661542308, 1034.043509753475, 765.4756491803132, 766.2031487253195, 767.2289349204126, 778.7975126467046, 786.1470304719329, 5214.45248248936, 5353.464653534693, 5388.5419739321815, 5588.6646801192055, 5598.776048958078, 795.6459375577813, 796.77690246731, 807.5195258820992, 866.2377108144792, 888.8888888888889, 3303.124671961932, 3558.252766918976, 3599.9280014400088, 3622.239329740731, 3637.127089498554, 9219.308551858638, 9628.133467987915, 9632.614695412245, 9643.614255429704, 9643.951780241054, 9543.856842147374, 9555.569999350046, 9583.904160958302, 9592.95203523978, 9610.135087842127, 7074.575525468488, 7185.748498802622, 7190.209077001526, 7193.748218812421, 7209.315115064165, 5245.895082098413, 5323.0684630190335, 5383.138697808332, 5441.156620723794, 5559.388467268516, 8390.874136887829, 9026.45841249527, 9068.50123243228, 9077.455352678597, 9095.954520227357, 8018.358531317597, 8261.628226729932, 9060.365774395728, 9106.408083474553, 9155.587998539948, 5749.396313387034, 6015.097735339734, 6572.572782769104, 6742.730290788313, 6746.4265537429865, 6763.729450822108, 7071.71713131469, 7085.574865508086, 7085.6457177141965, 7091.078159839188, 6295.779647712308, 6477.546571739933, 6500.804975850732, 6595.703193356215, 6631.900521492278, 6252.218472690914, 6297.149884765681, 6310.432061114522, 6345.90481142774, 6402.903956440564, 6247.562670613013, 6334.366563343813, 6339.683015849097, 6340.651264180515, 6341.8097457076365, 4526.751028693454, 4536.251518499411, 4544.6818722689095, 4622.791974361229, 4688.906221875612, 4580.198465268498, 4616.192166370939, 4620.353150558857, 4685.976570117127, 4747.952520474751], "value": 4045.424803896733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.98919689261174, 298.3510863871081, 298.3763933379238, 299.6314533124257, 302.38464724286075, 4893.877653058671, 4911.189653707139, 4924.67989580677, 4933.851984440473, 4936.160852655048, 4855.465898751135, 4880.975595122029, 4907.705537667743, 4922.7538623068795, 4937.210046392578, 3687.815609219535, 3782.2624588205313, 3804.6385593368723, 3890.9805450972704, 3909.335412979786, 3851.6697398074043, 3853.9381430934454, 3860.1893602343544, 3863.9613603864022, 3881.961180388188, 3816.9579275087835, 3824.292505886406, 3841.6938240998056, 3843.2889915365745, 3848.0, 3684.189478314753, 3722.8696995605023, 3849.0, 3872.3029854626157, 3879.7866117363533, 3390.1694084949345, 3397.813120278384, 3404.370191514553, 3409.7954122752712, 3437.2781715839706, 4808.230683090724, 4811.182099043136, 4813.3983252093485, 4818.397700287464, 4819.204831202847, 4317.460317460317, 4391.736495810262, 4416.646668266563, 4430.8449204277695, 4433.711808732454, 5120.5903527718065, 5132.56373208274, 5143.7685304161405, 5154.201098829687, 5163.922541161885, 3751.2497500499735, 3767.208886133888, 3790.336691079078, 3790.4314352847296, 3800.8289626966853, 5311.1767676009895, 5397.487238712355, 5434.451181413278, 5482.342118945752, 5484.533814625762, 3807.2766174427325, 3829.5213098362706, 3831.9616803831605, 3852.730308878408, 3853.344931361675, 3900.6099390061336, 3913.62820532049, 3916.118873253495, 3919.353306704362, 3926.1166237596885, 4417.315316126005, 4419.801108950105, 4427.158839820424, 4441.356003379492, 4449.755263460541, 5062.82280120194, 5099.974500127476, 5101.311322971425, 5110.0, 5131.204663277198, 1295.9567548123662, 1307.9209652036918, 1308.3981368570373, 1310.0960337367187, 1311.2001678975817, 836.6569706420338, 841.7432683031611, 868.9522076285865, 869.9217070463562, 873.2315562305258, 4350.412694286294, 4490.842820501332, 4504.729716216972, 4505.662075344297, 4509.7970591323465, 5185.9740701297005, 5228.039485193052, 5287.735613219324, 5294.49702278283, 5321.228421878884, 4554.407926969473, 4568.680192386568, 4569.2689169732685, 4576.702514336557, 4582.450105987236, 2685.7179996100126, 2813.4373125375005, 2821.830690158597, 2829.7124808212216, 2829.915102546927, 4967.615544538642, 4975.651704380731, 4979.551840334315, 4985.675931064469, 4986.601071914238, 5194.636375453682, 5411.783528658888, 5423.0, 5426.538744206787, 5441.374241962225, 4995.350604421475, 5013.373328333958, 5016.272640467185, 5030.144875371196, 5030.3963524377305, 5346.919796202982, 5347.866303342447, 5376.865578360573, 5422.902471676612, 5427.670220795931, 5150.052257004957, 5215.13950198213, 5215.269862219368, 5234.712090835041, 5265.078611243094, 5016.347874776402, 5024.598032157492, 5030.170021946338, 5033.295338652519, 5038.874028149326, 3735.9252814944093, 3748.4939533162674, 3775.0939774453386, 3781.3760729479327, 3785.734998550075, 5109.9233511498105, 5333.9466605335, 5379.35447746273, 5428.83713488596, 5450.291462109901, 5174.249733788655, 5179.974100129475, 5181.119209734429, 5183.144781111226, 5203.8178663746585, 5151.793928242828, 5173.870653233699, 5184.170532714747, 5194.805194805243, 5233.461771040966, 4863.2461968394955, 5097.260897169964, 5111.105556527518, 5125.0, 5129.538341549279, 4942.678725882806, 5061.886384995295, 5216.686998780086, 5226.738663066755, 5231.42454330031, 5074.133114790132, 5085.389753229636, 5089.7709603067215, 5100.260462232881, 5101.668391554537], "value": 3896.5445462765692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5361344957657, 619.2259675405743, 669.4075742967473, 715.7924201981425, 746.4327111395341, 12254.326012069343, 12638.684032899158, 13165.60503184906, 13169.868301316996, 13172.20966741995, 12754.426050827711, 13010.869891301109, 13040.543580974669, 13040.608781736539, 13051.543195988143, 632.7595513704786, 771.4137255685691, 790.0756115345031, 792.3186059988406, 792.374024520628, 642.8457170279123, 647.8445173158432, 655.2726473614284, 655.7442597387, 751.7218629107238, 819.2012787532168, 828.8176601147768, 833.2500749325625, 833.7665453672981, 834.2741814621288, 828.8508068547659, 829.0134739659816, 829.3448175940999, 829.5230242610523, 829.9917000830005, 483.23889873449457, 565.047894298109, 607.2288193993603, 607.4502575169435, 607.480604083511, 12077.45651445687, 12552.121351505399, 12573.811392829115, 12578.559750408784, 12606.054545909003, 11489.942550287195, 12260.570880019246, 12688.429020694091, 12883.88015692548, 12909.419076141503, 11546.53813847445, 11656.825147622792, 11821.17251792375, 11902.761944761143, 11990.760184796343, 3893.1240470894104, 3934.7048971327263, 3945.940810887839, 3991.381335892941, 4018.2365350583295, 61869.381306187264, 63823.0, 63907.68046159786, 64024.679876600785, 64975.67512162409, 9266.258699304039, 9562.187214086742, 10080.949595252123, 10313.071823535918, 10368.429736364573, 17099.658006839793, 17223.56941076458, 17345.392911248047, 17390.739138912926, 17442.215100320514, 6326.49388048955, 6458.0, 6482.935170648328, 6494.9675251624385, 6647.767328143492, 3651.9634803652157, 3714.23858109087, 3733.5893051764283, 3755.4366844973474, 3773.132179598708, 2707.634469346613, 2778.6665600128113, 2792.3437992071845, 2797.0909454426987, 2797.8321300722023, 497.6242936582857, 504.27132793114333, 506.72890003847766, 511.7134404733361, 519.4052809533064, 471.8442913838425, 525.0575217484625, 543.6384804105226, 550.5843088468181, 566.4165909113619, 7106.609136497439, 7396.852062958711, 7426.331630153312, 7475.476716629783, 7485.723413601698, 505.2623170171591, 528.2815371095307, 538.5852893272158, 543.4998608958296, 549.3901769036366, 3448.8103154326755, 3600.1899572595958, 3678.9448158277646, 3725.8509659613856, 3802.5627052888717, 76689.23310766932, 77688.61155694185, 96709.5164524187, 99003.0, 99914.50042749739, 68036.319636803, 69624.0, 69848.0, 82103.0, 84032.0, 69539.65230173917, 71143.0, 72388.63805680937, 73223.63388183131, 75211.0, 8009.3192078673965, 8311.127331630092, 8344.87482687748, 8460.255312408903, 8545.060043395097, 31790.36419271648, 37508.43737343996, 39905.0, 43696.56303436925, 44221.778891105336, 53594.19608705794, 53922.460775391744, 56141.0, 56340.15489767575, 61463.0, 10986.505607247853, 11228.326300422, 11365.090792736395, 11514.80830178933, 11702.180847340604, 12567.0, 13108.737825243252, 13175.538856140372, 13311.800322995357, 13328.666783330495, 11564.190506664452, 11640.126990475579, 11677.124215684027, 11703.23928944616, 11728.472218750007, 11236.943815281198, 11636.767264654829, 11645.47595358194, 12064.51741930348, 12256.203346782431, 11635.0, 11643.650690479299, 11869.703257418634, 11969.401529923294, 12468.189567678071, 9468.337216394786, 9704.320697551386, 10016.599336026477, 10357.22320825926, 10732.946335268274, 9344.626214951326, 9763.267754918552, 9803.215742740422, 9897.455639939872, 9934.900650993686], "value": 6390.993638288549, "unit": "score"}], "name": "dromaeo_css", "value": 6332.312739059482, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 112.0, 112.0, 113.0, 112.0, 114.0, 115.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 124.0, 202.0, 124.0, 130.0, 147.0, 126.0, 157.0, 130.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 170.0, 160.0, 159.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 119.0, 75.0, 76.0, 75.0, 75.0, 102.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 86.0, 84.0, 87.0, 129.0, 85.0, 85.0, 126.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 68.0, 70.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 85.0, 80.0, 89.0, 78.0, 80.0, 80.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 128.0, 137.0, 133.0, 128.0, 129.0, 127.0, 184.0, 131.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 165.0, 167.0, 166.0, 165.0, 167.0, 164.0, 165.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 74.0, 67.0, 67.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1534.7, "alertThreshold": 2.0}]} 09:36:00 INFO - Return code: 0 09:36:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:00 INFO - # TBPL SUCCESS # 09:36:00 INFO - Running post-action listener: _resource_record_post_action 09:36:00 INFO - [mozharness: 2016-07-27 16:36:00.529172Z] Finished run-tests step (success) 09:36:00 INFO - Running post-run listener: _resource_record_post_run 09:36:00 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7680000; Write bytes: 332361728; Read time: 1068; Write time: 313392 09:36:00 INFO - TinderboxPrint: CPU usage
13.0% 09:36:00 INFO - TinderboxPrint: I/O read bytes / time
7,680,000 / 1,068 09:36:00 INFO - TinderboxPrint: I/O write bytes / time
332,361,728 / 313,392 09:36:00 INFO - TinderboxPrint: CPU idle
8,354.7 (87.0%) 09:36:00 INFO - TinderboxPrint: CPU user
1,198.9 (12.5%) 09:36:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 55287808; Read time: 48; Write time: 39740 09:36:00 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5619712; Write bytes: 276373504; Read time: 916; Write time: 272408 09:36:01 INFO - Running post-run listener: _upload_blobber_files 09:36:01 INFO - Blob upload gear active. 09:36:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:36:01 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:01 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:06 INFO - (blobuploader) - INFO - Done attempting. 09:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:07 INFO - (blobuploader) - INFO - Done attempting. 09:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:08 INFO - (blobuploader) - INFO - Done attempting. 09:36:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:08 INFO - Return code: 0 09:36:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8cc5ff41b81bdd986477493fd8916f223171baa9db7bf3f9eb719938f185ed3c232ca7fa3a6621ea58d0e2f05cc412b2a0fe3f931546155bb3e0a5ab2442b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b3c514a7ed291b5647fe70de3247001d45eee3b4e65f25cd2868240f0ef926f1913a938c21abdc872f1d1a5f0210c15470f440b1b17e231d6f755e13a23ce7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a79af88eadfb8a5347fad12e6889980efc26bfba74106a4f8170cdab33375a24d796b52c62b9db33dbce5d230d50e2fb03f03016138a6f1fc875848fbb7a8d80"} 09:36:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:08 INFO - Contents: 09:36:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8cc5ff41b81bdd986477493fd8916f223171baa9db7bf3f9eb719938f185ed3c232ca7fa3a6621ea58d0e2f05cc412b2a0fe3f931546155bb3e0a5ab2442b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b3c514a7ed291b5647fe70de3247001d45eee3b4e65f25cd2868240f0ef926f1913a938c21abdc872f1d1a5f0210c15470f440b1b17e231d6f755e13a23ce7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a79af88eadfb8a5347fad12e6889980efc26bfba74106a4f8170cdab33375a24d796b52c62b9db33dbce5d230d50e2fb03f03016138a6f1fc875848fbb7a8d80"} 09:36:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:08 INFO - Copying logs to upload dir... 09:36:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.232966 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-27 09:36:08.240235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 09:36:08.243471) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8cc5ff41b81bdd986477493fd8916f223171baa9db7bf3f9eb719938f185ed3c232ca7fa3a6621ea58d0e2f05cc412b2a0fe3f931546155bb3e0a5ab2442b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b3c514a7ed291b5647fe70de3247001d45eee3b4e65f25cd2868240f0ef926f1913a938c21abdc872f1d1a5f0210c15470f440b1b17e231d6f755e13a23ce7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a79af88eadfb8a5347fad12e6889980efc26bfba74106a4f8170cdab33375a24d796b52c62b9db33dbce5d230d50e2fb03f03016138a6f1fc875848fbb7a8d80"} build_url:https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/dPVCZdDvT0iBDPA37U-YKw/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/Firefox-Non-PGO/sha512/2e8cc5ff41b81bdd986477493fd8916f223171baa9db7bf3f9eb719938f185ed3c232ca7fa3a6621ea58d0e2f05cc412b2a0fe3f931546155bb3e0a5ab2442b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b3c514a7ed291b5647fe70de3247001d45eee3b4e65f25cd2868240f0ef926f1913a938c21abdc872f1d1a5f0210c15470f440b1b17e231d6f755e13a23ce7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a79af88eadfb8a5347fad12e6889980efc26bfba74106a4f8170cdab33375a24d796b52c62b9db33dbce5d230d50e2fb03f03016138a6f1fc875848fbb7a8d80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 09:36:08.269843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:36:08.270178) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469636113.111410-1600883568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004355 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:36:08.353374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 09:36:08.353972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 09:36:08.354513) ========= ========= Total master_lag: -0.04 =========