builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1469578154.56 results: success (0) buildid: 20160726154612 builduid: d6308a41e3b247d9a2fbb623a870252a revision: 8c361c7cc683e24771a973f2b822fd84605db0ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.559666) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.560156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.560446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.576990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.577383) ========= 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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 17:09:15-- 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% 217M=0s 2016-07-26 17:09:15 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.687922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.688309) ========= 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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022812 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:14.773785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 17:09:14.774183) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c361c7cc683e24771a973f2b822fd84605db0ed --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 8c361c7cc683e24771a973f2b822fd84605db0ed --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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 17:09:15,516 truncating revision to first 12 chars 2016-07-26 17:09:15,516 Setting DEBUG logging. 2016-07-26 17:09:15,516 attempt 1/10 2016-07-26 17:09:15,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c361c7cc683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 17:09:16,831 unpacking tar archive at: mozilla-central-8c361c7cc683/testing/mozharness/ program finished with exit code 0 elapsedTime=1.655083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 17:09:16.443092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:16.443431) ========= script_repo_revision: 8c361c7cc683e24771a973f2b822fd84605db0ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:16.443883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:16.444172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 17:09:16.454726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-26 17:09:16.455128) ========= /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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:17 INFO - MultiFileLogger online at 20160726 17:09:17 in /builds/slave/test 17:09:17 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 17:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:17 INFO - {'append_to_log': False, 17:09:17 INFO - 'base_work_dir': '/builds/slave/test', 17:09:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:17 INFO - 'branch': 'Firefox-Non-PGO', 17:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:17 INFO - 'config_files': ('talos/linux_config.py',), 17:09:17 INFO - 'default_actions': ('clobber', 17:09:17 INFO - 'read-buildbot-config', 17:09:17 INFO - 'download-and-extract', 17:09:17 INFO - 'populate-webroot', 17:09:17 INFO - 'create-virtualenv', 17:09:17 INFO - 'install', 17:09:17 INFO - 'run-tests'), 17:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:17 INFO - 'download_minidump_stackwalk': True, 17:09:17 INFO - 'download_symbols': 'ondemand', 17:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:17 INFO - 'installer_path': 'installer.exe', 17:09:17 INFO - 'log_level': 'info', 17:09:17 INFO - 'log_name': 'talos', 17:09:17 INFO - 'log_to_console': True, 17:09:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:17 INFO - 'opt_config_files': (), 17:09:17 INFO - 'pip_index': False, 17:09:17 INFO - 'sps_profile': False, 17:09:17 INFO - 'sps_profile_interval': 0, 17:09:17 INFO - 'suite': 'dromaeojs', 17:09:17 INFO - 'system_bits': '32', 17:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:17 INFO - 'title': 'talos-linux64-ix-065', 17:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:17 INFO - 'use_talos_json': True, 17:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:17 INFO - 'work_dir': 'build'} 17:09:17 INFO - [mozharness: 2016-07-27 00:09:17.285334Z] Running clobber step. 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: clobber 17:09:17 INFO - rmtree: /builds/slave/test/build 17:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:17 INFO - Running post-action listener: _resource_record_post_action 17:09:17 INFO - [mozharness: 2016-07-27 00:09:17.758222Z] Finished clobber step (success) 17:09:17 INFO - [mozharness: 2016-07-27 00:09:17.758324Z] Running read-buildbot-config step. 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: read_buildbot_config 17:09:17 INFO - Using buildbot properties: 17:09:17 INFO - { 17:09:17 INFO - "project": "", 17:09:17 INFO - "product": "firefox", 17:09:17 INFO - "script_repo_revision": "production", 17:09:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:09:17 INFO - "repository": "", 17:09:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:09:17 INFO - "buildid": "20160726154612", 17:09:17 INFO - "pgo_build": "False", 17:09:17 INFO - "basedir": "/builds/slave/test", 17:09:17 INFO - "buildnumber": 568, 17:09:17 INFO - "slavename": "talos-linux64-ix-065", 17:09:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:09:17 INFO - "platform": "ubuntu64_hw", 17:09:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:09:17 INFO - "branch": "mozilla-central", 17:09:17 INFO - "repo_path": "mozilla-central", 17:09:17 INFO - "revision": "8c361c7cc683e24771a973f2b822fd84605db0ed", 17:09:17 INFO - "stage_platform": "linux64", 17:09:17 INFO - "builduid": "d6308a41e3b247d9a2fbb623a870252a", 17:09:17 INFO - "slavebuilddir": "test" 17:09:17 INFO - } 17:09:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:09:17 INFO - Running post-action listener: _resource_record_post_action 17:09:17 INFO - [mozharness: 2016-07-27 00:09:17.761124Z] Finished read-buildbot-config step (success) 17:09:17 INFO - [mozharness: 2016-07-27 00:09:17.761214Z] Running download-and-extract step. 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: download_and_extract 17:09:17 INFO - mkdir: /builds/slave/test/build/tests 17:09: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')]} 17:09:17 INFO - https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:21 INFO - Downloaded 1361 bytes. 17:09:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:21 INFO - Using the following test package requirements: 17:09:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'jsshell-linux-x86_64.zip'], 17:09:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:21 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')]} 17:09:21 INFO - https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:24 INFO - Downloaded 22742005 bytes. 17:09:24 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'] 17:09:24 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 17:09:25 INFO - Return code: 0 17:09:25 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 17:09: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')]} 17:09:25 INFO - https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:31 INFO - Downloaded 22742005 bytes. 17:09:31 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'] 17:09:31 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 17:09:33 INFO - Return code: 0 17:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:33 INFO - https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:34 INFO - Downloaded 14413725 bytes. 17:09:34 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'] 17:09:34 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 17:09:34 INFO - Return code: 0 17:09:34 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')]} 17:09:34 INFO - https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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 17:09:36 INFO - Downloaded 57166228 bytes. 17:09:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:36 INFO - mkdir: /builds/slave/test/properties 17:09:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:36 INFO - Contents: 17:09:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:36 INFO - Running post-action listener: _resource_record_post_action 17:09:36 INFO - Running post-action listener: set_extra_try_arguments 17:09:36 INFO - [mozharness: 2016-07-27 00:09:36.907308Z] Finished download-and-extract step (success) 17:09:36 INFO - [mozharness: 2016-07-27 00:09:36.907629Z] Running populate-webroot step. 17:09:36 INFO - Running pre-action listener: _resource_record_pre_action 17:09:36 INFO - Running main action method: populate_webroot 17:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:36 INFO - '--tppagecycles', 17:09:36 INFO - '7'], 17:09:36 INFO - 'tests': ['tsvgm']}}, 17:09:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['damp', 'tps']}, 17:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'tests': ['damp', 'tps']}, 17:09:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['dromaeo_dom']}, 17:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['basic_compositor_video']}, 17:09:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:09:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['a11yr', 17:09:36 INFO - 'ts_paint', 17:09:36 INFO - 'tpaint', 17:09:36 INFO - 'sessionrestore', 17:09:36 INFO - 'sessionrestore_no_auto_restore', 17:09:36 INFO - 'tabpaint']}, 17:09:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['tsvgx', 17:09:36 INFO - 'tsvgr_opacity', 17:09:36 INFO - 'tart', 17:09:36 INFO - 'tscrollx', 17:09:36 INFO - 'cart']}, 17:09:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:36 INFO - 'tsvgr_opacity', 17:09:36 INFO - 'tart', 17:09:36 INFO - 'tscrollx', 17:09:36 INFO - 'cart']}, 17:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'talos_options': ['--disable-e10s'], 17:09:36 INFO - 'tests': ['tp5o']}, 17:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'tests': ['tp5o']}, 17:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'talos_options': ['--disable-e10s', 17:09:36 INFO - '--xperf_path', 17:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:36 INFO - 'tests': ['tp5n']}, 17:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:36 INFO - 'talos_options': ['--xperf_path', 17:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:36 INFO - 'tests': ['tp5n']}}, 17:09:36 INFO - 'talos.zip': {'path': '', 17:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:36 INFO - Running post-action listener: _resource_record_post_action 17:09:36 INFO - [mozharness: 2016-07-27 00:09:36.927416Z] Finished populate-webroot step (success) 17:09:36 INFO - [mozharness: 2016-07-27 00:09:36.927507Z] Running create-virtualenv step. 17:09:36 INFO - Running pre-action listener: _resource_record_pre_action 17:09:36 INFO - Running main action method: create_virtualenv 17:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:37 INFO - Using real prefix '/usr' 17:09:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:39 INFO - Installing pip.................done. 17:09:39 INFO - Return code: 0 17:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:39 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:39 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 17:09:39 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 17:09:39 INFO - Using env: {'DISPLAY': ':0', 17:09:39 INFO - 'HOME': '/home/cltbld', 17:09:39 INFO - 'LANG': 'en_US.UTF-8', 17:09:39 INFO - 'LANGUAGE': 'en_US:en', 17:09:39 INFO - 'LOGNAME': 'cltbld', 17:09:39 INFO - 'MAIL': '/var/mail/cltbld', 17:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:39 INFO - 'MOZ_NO_REMOTE': '1', 17:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:39 INFO - 'NO_EM_RESTART': '1', 17:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:39 INFO - 'PWD': '/builds/slave/test', 17:09:39 INFO - 'SHELL': '/bin/bash', 17:09:39 INFO - 'SHLVL': '1', 17:09:39 INFO - 'TERM': 'linux', 17:09:39 INFO - 'TMOUT': '86400', 17:09:39 INFO - 'USER': 'cltbld', 17:09:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:39 INFO - '_': '/tools/buildbot/bin/python'} 17:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:39 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 17:09:39 INFO - Cleaning up... 17:09:39 INFO - Return code: 0 17:09:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:39 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:39 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 17:09:39 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 17:09:39 INFO - Using env: {'DISPLAY': ':0', 17:09:39 INFO - 'HOME': '/home/cltbld', 17:09:39 INFO - 'LANG': 'en_US.UTF-8', 17:09:39 INFO - 'LANGUAGE': 'en_US:en', 17:09:39 INFO - 'LOGNAME': 'cltbld', 17:09:39 INFO - 'MAIL': '/var/mail/cltbld', 17:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:39 INFO - 'MOZ_NO_REMOTE': '1', 17:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:39 INFO - 'NO_EM_RESTART': '1', 17:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:39 INFO - 'PWD': '/builds/slave/test', 17:09:39 INFO - 'SHELL': '/bin/bash', 17:09:39 INFO - 'SHLVL': '1', 17:09:39 INFO - 'TERM': 'linux', 17:09:39 INFO - 'TMOUT': '86400', 17:09:39 INFO - 'USER': 'cltbld', 17:09:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:39 INFO - '_': '/tools/buildbot/bin/python'} 17:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:39 INFO - Downloading/unpacking psutil>=3.1.1 17:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:41 INFO - Installing collected packages: psutil 17:09:41 INFO - Running setup.py install for psutil 17:09:42 INFO - building 'psutil._psutil_linux' extension 17:09:42 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 17:09:42 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 17:09:42 INFO - building 'psutil._psutil_posix' extension 17:09:42 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 17:09:42 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 17:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:42 INFO - Successfully installed psutil 17:09:42 INFO - Cleaning up... 17:09:42 INFO - Return code: 0 17:09:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:09: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 mozsystemmonitor==0.3 17:09:42 INFO - Using env: {'DISPLAY': ':0', 17:09:42 INFO - 'HOME': '/home/cltbld', 17:09:42 INFO - 'LANG': 'en_US.UTF-8', 17:09:42 INFO - 'LANGUAGE': 'en_US:en', 17:09:42 INFO - 'LOGNAME': 'cltbld', 17:09:42 INFO - 'MAIL': '/var/mail/cltbld', 17:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:42 INFO - 'MOZ_NO_REMOTE': '1', 17:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:42 INFO - 'NO_EM_RESTART': '1', 17:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:42 INFO - 'PWD': '/builds/slave/test', 17:09:42 INFO - 'SHELL': '/bin/bash', 17:09:42 INFO - 'SHLVL': '1', 17:09:42 INFO - 'TERM': 'linux', 17:09:42 INFO - 'TMOUT': '86400', 17:09:42 INFO - 'USER': 'cltbld', 17:09:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:42 INFO - '_': '/tools/buildbot/bin/python'} 17:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:44 INFO - Installing collected packages: mozsystemmonitor 17:09:44 INFO - Running setup.py install for mozsystemmonitor 17:09:44 INFO - Successfully installed mozsystemmonitor 17:09:44 INFO - Cleaning up... 17:09:44 INFO - Return code: 0 17:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:09:44 INFO - Using env: {'DISPLAY': ':0', 17:09:44 INFO - 'HOME': '/home/cltbld', 17:09:44 INFO - 'LANG': 'en_US.UTF-8', 17:09:44 INFO - 'LANGUAGE': 'en_US:en', 17:09:44 INFO - 'LOGNAME': 'cltbld', 17:09:44 INFO - 'MAIL': '/var/mail/cltbld', 17:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:44 INFO - 'MOZ_NO_REMOTE': '1', 17:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:44 INFO - 'NO_EM_RESTART': '1', 17:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:44 INFO - 'PWD': '/builds/slave/test', 17:09:44 INFO - 'SHELL': '/bin/bash', 17:09:44 INFO - 'SHLVL': '1', 17:09:44 INFO - 'TERM': 'linux', 17:09:44 INFO - 'TMOUT': '86400', 17:09:44 INFO - 'USER': 'cltbld', 17:09:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:44 INFO - '_': '/tools/buildbot/bin/python'} 17:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:45 INFO - Downloading/unpacking jsonschema==2.5.1 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:47 INFO - warning: no files found matching '*.txt' 17:09:47 INFO - no previously-included directories found matching 'build' 17:09:47 INFO - no previously-included directories found matching 'dist' 17:09:47 INFO - no previously-included directories found matching '.git*' 17:09:47 INFO - Installing collected packages: jsonschema, functools32 17:09:47 INFO - Running setup.py install for functools32 17:09:47 INFO - warning: no files found matching '*.txt' 17:09:47 INFO - no previously-included directories found matching 'build' 17:09:47 INFO - no previously-included directories found matching 'dist' 17:09:47 INFO - no previously-included directories found matching '.git*' 17:09:47 INFO - Successfully installed jsonschema functools32 17:09:47 INFO - Cleaning up... 17:09:47 INFO - Return code: 0 17:09:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:09:47 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')]} 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:47 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')]} 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:47 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:47 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 17:09:47 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 17:09:47 INFO - Using env: {'DISPLAY': ':0', 17:09:47 INFO - 'HOME': '/home/cltbld', 17:09:47 INFO - 'LANG': 'en_US.UTF-8', 17:09:47 INFO - 'LANGUAGE': 'en_US:en', 17:09:47 INFO - 'LOGNAME': 'cltbld', 17:09:47 INFO - 'MAIL': '/var/mail/cltbld', 17:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:47 INFO - 'MOZ_NO_REMOTE': '1', 17:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:47 INFO - 'NO_EM_RESTART': '1', 17:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:47 INFO - 'PWD': '/builds/slave/test', 17:09:47 INFO - 'SHELL': '/bin/bash', 17:09:47 INFO - 'SHLVL': '1', 17:09:47 INFO - 'TERM': 'linux', 17:09:47 INFO - 'TMOUT': '86400', 17:09:47 INFO - 'USER': 'cltbld', 17:09:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:47 INFO - '_': '/tools/buildbot/bin/python'} 17:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:09:47 INFO - Cleaning up... 17:09:47 INFO - Return code: 0 17:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:47 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')]} 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:47 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')]} 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:47 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:47 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 17:09:47 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 17:09:47 INFO - Using env: {'DISPLAY': ':0', 17:09:47 INFO - 'HOME': '/home/cltbld', 17:09:47 INFO - 'LANG': 'en_US.UTF-8', 17:09:47 INFO - 'LANGUAGE': 'en_US:en', 17:09:47 INFO - 'LOGNAME': 'cltbld', 17:09:47 INFO - 'MAIL': '/var/mail/cltbld', 17:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:47 INFO - 'MOZ_NO_REMOTE': '1', 17:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:47 INFO - 'NO_EM_RESTART': '1', 17:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:47 INFO - 'PWD': '/builds/slave/test', 17:09:47 INFO - 'SHELL': '/bin/bash', 17:09:47 INFO - 'SHLVL': '1', 17:09:47 INFO - 'TERM': 'linux', 17:09:47 INFO - 'TMOUT': '86400', 17:09:47 INFO - 'USER': 'cltbld', 17:09:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:47 INFO - '_': '/tools/buildbot/bin/python'} 17:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:50 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 17:09:50 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 17:09:50 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 17:09:50 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 17:09:50 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 17:09:50 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 17:09:50 INFO - Downloading docopt-0.6.1.tar.gz 17:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:50 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:50 INFO - Running setup.py install for blobuploader 17:09:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:50 INFO - Running setup.py install for requests 17:09:50 INFO - Running setup.py install for docopt 17:09:51 INFO - Successfully installed blobuploader requests docopt 17:09:51 INFO - Cleaning up... 17:09:51 INFO - Return code: 0 17:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:51 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')]} 17:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 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')]} 17:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:51 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 17:09:51 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 17:09:51 INFO - Using env: {'DISPLAY': ':0', 17:09:51 INFO - 'HOME': '/home/cltbld', 17:09:51 INFO - 'LANG': 'en_US.UTF-8', 17:09:51 INFO - 'LANGUAGE': 'en_US:en', 17:09:51 INFO - 'LOGNAME': 'cltbld', 17:09:51 INFO - 'MAIL': '/var/mail/cltbld', 17:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:51 INFO - 'MOZ_NO_REMOTE': '1', 17:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:51 INFO - 'NO_EM_RESTART': '1', 17:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:51 INFO - 'PWD': '/builds/slave/test', 17:09:51 INFO - 'SHELL': '/bin/bash', 17:09:51 INFO - 'SHLVL': '1', 17:09:51 INFO - 'TERM': 'linux', 17:09:51 INFO - 'TMOUT': '86400', 17:09:51 INFO - 'USER': 'cltbld', 17:09:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:51 INFO - '_': '/tools/buildbot/bin/python'} 17:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:51 INFO - Running setup.py (path:/tmp/pip-YqLmkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:51 INFO - Running setup.py (path:/tmp/pip-2IbHhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:51 INFO - Running setup.py (path:/tmp/pip-IzoX9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:51 INFO - Running setup.py (path:/tmp/pip-SCMJrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:51 INFO - Running setup.py (path:/tmp/pip-6L_CWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:51 INFO - Running setup.py (path:/tmp/pip-wWkfoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:51 INFO - Running setup.py (path:/tmp/pip-YtQt75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:51 INFO - Running setup.py (path:/tmp/pip-15FC_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:51 INFO - Running setup.py (path:/tmp/pip-C69qnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:52 INFO - Running setup.py (path:/tmp/pip-JdbyzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:52 INFO - Running setup.py (path:/tmp/pip-L1R_0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:52 INFO - Running setup.py (path:/tmp/pip-OyHavL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:52 INFO - Running setup.py (path:/tmp/pip-wvORTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:52 INFO - Running setup.py (path:/tmp/pip-XgVwJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:52 INFO - Running setup.py (path:/tmp/pip-YfKlQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:52 INFO - Running setup.py (path:/tmp/pip-XaL59i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:52 INFO - Running setup.py (path:/tmp/pip-HczUDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:52 INFO - Running setup.py install for manifestparser 17:09:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:52 INFO - Running setup.py install for mozcrash 17:09:52 INFO - Running setup.py install for mozdebug 17:09:52 INFO - Running setup.py install for mozdevice 17:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozfile 17:09:53 INFO - Running setup.py install for mozhttpd 17:09:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozinfo 17:09:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozInstall 17:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozleak 17:09:53 INFO - Running setup.py install for mozlog 17:09:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for moznetwork 17:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozprocess 17:09:53 INFO - Running setup.py install for mozprofile 17:09:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:53 INFO - Running setup.py install for mozrunner 17:09:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:54 INFO - Running setup.py install for mozscreenshot 17:09:54 INFO - Running setup.py install for moztest 17:09:54 INFO - Running setup.py install for mozversion 17:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:54 INFO - Cleaning up... 17:09:54 INFO - Return code: 0 17:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:54 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 17:09:54 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 17:09:54 INFO - Using env: {'DISPLAY': ':0', 17:09:54 INFO - 'HOME': '/home/cltbld', 17:09:54 INFO - 'LANG': 'en_US.UTF-8', 17:09:54 INFO - 'LANGUAGE': 'en_US:en', 17:09:54 INFO - 'LOGNAME': 'cltbld', 17:09:54 INFO - 'MAIL': '/var/mail/cltbld', 17:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:54 INFO - 'MOZ_NO_REMOTE': '1', 17:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:54 INFO - 'NO_EM_RESTART': '1', 17:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:54 INFO - 'PWD': '/builds/slave/test', 17:09:54 INFO - 'SHELL': '/bin/bash', 17:09:54 INFO - 'SHLVL': '1', 17:09:54 INFO - 'TERM': 'linux', 17:09:54 INFO - 'TMOUT': '86400', 17:09:54 INFO - 'USER': 'cltbld', 17:09:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:54 INFO - '_': '/tools/buildbot/bin/python'} 17:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:54 INFO - Running setup.py (path:/tmp/pip-vQycDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:54 INFO - Running setup.py (path:/tmp/pip-mm5RXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:54 INFO - Running setup.py (path:/tmp/pip-ZuXZSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:54 INFO - Running setup.py (path:/tmp/pip-JLvCoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:54 INFO - Running setup.py (path:/tmp/pip-QIUuV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:54 INFO - Running setup.py (path:/tmp/pip-gHUgaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:54 INFO - Running setup.py (path:/tmp/pip-aWj_a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:55 INFO - Running setup.py (path:/tmp/pip-gfyqWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:55 INFO - Running setup.py (path:/tmp/pip-O9V9tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:55 INFO - Running setup.py (path:/tmp/pip-epokYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:55 INFO - Running setup.py (path:/tmp/pip-2a2ECC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:55 INFO - Running setup.py (path:/tmp/pip-iatF6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:55 INFO - Running setup.py (path:/tmp/pip-xQwSSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:55 INFO - Running setup.py (path:/tmp/pip-bax77g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:55 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)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:55 INFO - Running setup.py (path:/tmp/pip-1WF_zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:55 INFO - Running setup.py (path:/tmp/pip-CpqKch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:55 INFO - Running setup.py (path:/tmp/pip-NYFBaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:57 INFO - Downloading blessings-1.6.tar.gz 17:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:57 INFO - Installing collected packages: blessings 17:09:57 INFO - Running setup.py install for blessings 17:09:57 INFO - Successfully installed blessings 17:09:57 INFO - Cleaning up... 17:09:57 INFO - Return code: 0 17:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:58 INFO - Reading from file tmpfile_stdout 17:09:58 INFO - Current package versions: 17:09:58 INFO - argparse == 1.2.1 17:09:58 INFO - blessings == 1.6 17:09:58 INFO - blobuploader == 1.2.4 17:09:58 INFO - docopt == 0.6.1 17:09:58 INFO - functools32 == 3.2.3-2 17:09:58 INFO - jsonschema == 2.5.1 17:09:58 INFO - manifestparser == 1.1 17:09:58 INFO - mozInstall == 1.12 17:09:58 INFO - mozcrash == 0.17 17:09:58 INFO - mozdebug == 0.1 17:09:58 INFO - mozdevice == 0.48 17:09:58 INFO - mozfile == 1.2 17:09:58 INFO - mozhttpd == 0.7 17:09:58 INFO - mozinfo == 0.9 17:09:58 INFO - mozleak == 0.1 17:09:58 INFO - mozlog == 3.3 17:09:58 INFO - moznetwork == 0.27 17:09:58 INFO - mozprocess == 0.23 17:09:58 INFO - mozprofile == 0.28 17:09:58 INFO - mozrunner == 6.12 17:09:58 INFO - mozscreenshot == 0.1 17:09:58 INFO - mozsystemmonitor == 0.3 17:09:58 INFO - moztest == 0.7 17:09:58 INFO - mozversion == 1.4 17:09:58 INFO - psutil == 3.1.1 17:09:58 INFO - requests == 1.2.3 17:09:58 INFO - wsgiref == 0.1.2 17:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:58 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:58 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 17:09:58 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 17:09:58 INFO - Using env: {'DISPLAY': ':0', 17:09:58 INFO - 'HOME': '/home/cltbld', 17:09:58 INFO - 'LANG': 'en_US.UTF-8', 17:09:58 INFO - 'LANGUAGE': 'en_US:en', 17:09:58 INFO - 'LOGNAME': 'cltbld', 17:09:58 INFO - 'MAIL': '/var/mail/cltbld', 17:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:58 INFO - 'MOZ_NO_REMOTE': '1', 17:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:58 INFO - 'NO_EM_RESTART': '1', 17:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:58 INFO - 'PWD': '/builds/slave/test', 17:09:58 INFO - 'SHELL': '/bin/bash', 17:09:58 INFO - 'SHLVL': '1', 17:09:58 INFO - 'TERM': 'linux', 17:09:58 INFO - 'TMOUT': '86400', 17:09:58 INFO - 'USER': 'cltbld', 17:09:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:58 INFO - '_': '/tools/buildbot/bin/python'} 17:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 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)) 17:09:58 INFO - Cleaning up... 17:09:58 INFO - Return code: 0 17:09:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:58 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 0x2120030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, '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': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', '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 17:09:58 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 17:09:58 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 17:09:58 INFO - Using env: {'DISPLAY': ':0', 17:09:58 INFO - 'HOME': '/home/cltbld', 17:09:58 INFO - 'LANG': 'en_US.UTF-8', 17:09:58 INFO - 'LANGUAGE': 'en_US:en', 17:09:58 INFO - 'LOGNAME': 'cltbld', 17:09:58 INFO - 'MAIL': '/var/mail/cltbld', 17:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:58 INFO - 'MOZ_NO_REMOTE': '1', 17:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:58 INFO - 'NO_EM_RESTART': '1', 17:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:58 INFO - 'PWD': '/builds/slave/test', 17:09:58 INFO - 'SHELL': '/bin/bash', 17:09:58 INFO - 'SHLVL': '1', 17:09:58 INFO - 'TERM': 'linux', 17:09:58 INFO - 'TMOUT': '86400', 17:09:58 INFO - 'USER': 'cltbld', 17:09:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:58 INFO - '_': '/tools/buildbot/bin/python'} 17:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:58 INFO - Cleaning up... 17:09:58 INFO - Return code: 0 17:09:58 INFO - Running post-action listener: _resource_record_post_action 17:09:58 INFO - Running post-action listener: _start_resource_monitoring 17:09:58 INFO - Starting resource monitoring. 17:09:58 INFO - [mozharness: 2016-07-27 00:09:58.640774Z] Finished create-virtualenv step (success) 17:09:58 INFO - [mozharness: 2016-07-27 00:09:58.641208Z] Running install step. 17:09:58 INFO - Running pre-action listener: _resource_record_pre_action 17:09:58 INFO - Running main action method: install 17:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:58 INFO - Reading from file tmpfile_stdout 17:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:58 INFO - Reading from file tmpfile_stdout 17:09:58 INFO - Output received: 17:09:58 INFO - Usage: mozinstall [options] installer 17:09:58 INFO - Options: 17:09:58 INFO - -h, --help show this help message and exit 17:09:58 INFO - -d DEST, --destination=DEST 17:09:58 INFO - Directory to install application into. [default: 17:09:58 INFO - "/builds/slave/test"] 17:09:58 INFO - --app=APP Application being installed. [default: firefox] 17:09:58 INFO - mkdir: /builds/slave/test/build/application 17:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:15 INFO - Reading from file tmpfile_stdout 17:10:15 INFO - Output received: 17:10:15 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:15 INFO - Running post-action listener: _resource_record_post_action 17:10:15 INFO - [mozharness: 2016-07-27 00:10:15.396884Z] Finished install step (success) 17:10:15 INFO - [mozharness: 2016-07-27 00:10:15.397164Z] Running run-tests step. 17:10:15 INFO - Running pre-action listener: _resource_record_pre_action 17:10:15 INFO - Running main action method: run_tests 17:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:15 INFO - Python 2.7.3 17:10:15 INFO - Return code: 0 17:10:15 INFO - grabbing minidump binary from tooltool 17:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df3b0>, '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 0x23e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:10:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:10:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:15 INFO - Return code: 0 17:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:15 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/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 17:10:15 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/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 17:10:15 INFO - Using env: {'DISPLAY': ':0', 17:10:15 INFO - 'HOME': '/home/cltbld', 17:10:15 INFO - 'LANG': 'en_US.UTF-8', 17:10:15 INFO - 'LANGUAGE': 'en_US:en', 17:10:15 INFO - 'LOGNAME': 'cltbld', 17:10:15 INFO - 'MAIL': '/var/mail/cltbld', 17:10:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:15 INFO - 'MOZ_NO_REMOTE': '1', 17:10:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:15 INFO - 'NO_EM_RESTART': '1', 17:10:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:15 INFO - 'PWD': '/builds/slave/test', 17:10:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:15 INFO - 'SHELL': '/bin/bash', 17:10:15 INFO - 'SHLVL': '1', 17:10:15 INFO - 'TERM': 'linux', 17:10:15 INFO - 'TMOUT': '86400', 17:10:15 INFO - 'USER': 'cltbld', 17:10:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411', 17:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:15 INFO - '_': '/tools/buildbot/bin/python'} 17:10:15 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/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 17:10:15 INFO - mozversion application_buildid: 20160726154612 17:10:15 INFO - mozversion application_changeset: 8c361c7cc683e24771a973f2b822fd84605db0ed 17:10:15 INFO - mozversion application_display_name: Nightly 17:10:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:15 INFO - mozversion application_name: Firefox 17:10:15 INFO - mozversion application_remotingname: firefox 17:10:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:10:15 INFO - mozversion application_vendor: Mozilla 17:10:15 INFO - mozversion application_version: 50.0a1 17:10:15 INFO - mozversion platform_buildid: 20160726154612 17:10:15 INFO - mozversion platform_changeset: 8c361c7cc683e24771a973f2b822fd84605db0ed 17:10:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:10:15 INFO - mozversion platform_version: 50.0a1 17:10:15 INFO - using testdate: 1469578215 17:10:15 INFO - actual date: 1469578215 17:10:15 INFO - starting webserver on 'localhost:34998' 17:10:15 INFO - SUITE-START | Running 2 tests 17:10:15 INFO - TEST-START | dromaeo_css 17:10:15 INFO - operating with platform_type : linux_ 17:10:15 INFO - Initialising browser for dromaeo_css test... 17:10:15 INFO - TEST-INFO | started process 16795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplsp5Zd/profile http://localhost:34998/getInfo.html) 17:10:19 INFO - PROCESS | 16795 | JavaScript error: , line 0: uncaught exception: undefined 17:10:20 INFO - PROCESS | 16795 | __metrics Screen width/height:1600/1200 17:10:20 INFO - PROCESS | 16795 | colorDepth:24 17:10:20 INFO - PROCESS | 16795 | Browser inner width/height: 1024/697 17:10:20 INFO - PROCESS | 16795 | __metrics 17:10:20 INFO - PROCESS | 16795 | 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" 17:10:20 INFO - PROCESS | 16795 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:21 INFO - TEST-INFO | 16795: exit 0 17:10:21 INFO - Browser initialized. 17:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:21 INFO - TEST-INFO | started process 16876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplsp5Zd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:33 INFO - PROCESS | 16876 | RSS: Main: 159326208 17:10:33 INFO - PROCESS | 16876 | 17:11:25 INFO - PROCESS | 16876 | 1469578285651 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] 17:13:37 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34998/tests/dromaeo/cssquery-ext.html) 17:13:38 INFO - PROCESS | 16876 | RSS: Main: 243875840 17:13:38 INFO - PROCESS | 16876 | 17:16:41 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-ext.html (next: http://localhost:34998/tests/dromaeo/cssquery-jquery.html) 17:16:41 INFO - PROCESS | 16876 | RSS: Main: 249745408 17:16:41 INFO - PROCESS | 16876 | 17:19:43 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34998/tests/dromaeo/cssquery-mootools.html) 17:19:44 INFO - PROCESS | 16876 | RSS: Main: 192073728 17:19:44 INFO - PROCESS | 16876 | 17:22:46 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34998/tests/dromaeo/cssquery-prototype.html) 17:22:47 INFO - PROCESS | 16876 | RSS: Main: 190062592 17:22:47 INFO - PROCESS | 16876 | 17:25:50 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34998/tests/dromaeo/cssquery-yui.html) 17:25:51 INFO - PROCESS | 16876 | RSS: Main: 190951424 17:25:51 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:34998/tests/dromaeo/cssquery-yui.html (next: http://localhost:34998/tests/dromaeo/cssquery-dojo.html) 17:28:54 INFO - PROCESS | 16876 | RSS: Main: 283013120 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | __start_tp_report 17:28:54 INFO - PROCESS | 16876 | _x_x_mozilla_page_load 17:28:54 INFO - PROCESS | 16876 | _x_x_mozilla_page_load_details 17:28:54 INFO - PROCESS | 16876 | |i|pagename|runs| 17:28:54 INFO - PROCESS | 16876 | |0;dojo.html;2622.6852777666677;2624;2656.853873036983;2671.0517766193;2674.1309074550777;4578.633709303256;4645.814167433307;4723.456802467717;4760.547747963947;4794.017226468574;4689;4699.835505757299;4705.976470117653;4746.620270378378;4746.762661866902;4361.6292615127595;4387.210302145612;4417.491988421324;4425.557444255564;4488.685791994561;4404.383386325917;4451.221036318631;4469.08383781324;4483.372327874084;4524.6380289576755;4289.270823959934;4330.069035157425;4359;4391.934120988188;4398.230309695822;4253.936190957138;4294.184105020036;4294.720843145185;4301.634361079312;4368.825246990116;4302.053548219386;4306.267934451151;4315.287977483711;4343.717658352229;4354.521002689701;4636.907261854744;4664.137134630104;4679.9298010529865;4716.787744551503;4742.50203728607;4991.351124353847;5017.2724954881705;5048.823291184827;5079.492050794928;5135.35808023997;5083.847484575469;5091.745412729349;5118.769655365518;5137.486251374833;5142;4600.447946246405;4742.999999999965;4780.545848144421;4785.090832741837;4785.95214047862;5154.664946778447;5161.612879034013;5194.740262986836;5254.054270231319;5259.8422047338645;5001.974990125026;5012.348394708664;5050.671706339076;5052.090623687772;5055.747212639427;4909.091818013679;5066.088104141216;5126.92309615356;5128.384593848762;5137.588992880561;4744.359511465908;4967.751612419437;4989.725565093955;5068.0370729562;5115.616328775282;5041.974790126099;5042.092423363756;5042.924356134661;5045.571126454219;5084.262781896604;4214.810333534998;4360.171567402183;4366.8034938427845;4367.366731823868;4415.602595766396;3702.278055779151;3786;3823.1397935464856;3860.7104467164513;3906.140649057203;4354.172707185625;4378.956210437918;4380.386745855582;4381.058072514425;4424.6681498887065;5137.743112844343;5143.7685304161405;5145.845624631267;5147.459516750762;5189.714565698923;4264.637505812041;4334.718243314174;4367.694261401735;4381.890452738707;4431.135928493977;4657.790399432034;4661.860144195612;4676.929846052312;4692.061587682477;4697.671163018625;4813.3983252093485;4818.349522814376;4819.277108433763;4829.5653391194965;4861.173600487996;4964.702117872939;5030.647854650139;5082.085224659597;5140.30605868203;5149.407818100816;4740.336352910665;4762.880927976828;4764.809407623657;4803.135435621622;4818.277258411266;5009.5992320615;5011.699298042129;5033.748312584283;5035.521625445577;5081.314022606901;4900.901981960412;4999.47505511916;5012.22310541852;5097.9490205098955;5154.381474223117;4924.089043526959;4928.827491037797;4939.506049395175;4958.851234462972;4962.429320628174;4905.068037072945;4906.6320025997475;4915.238138088602;4918.262260660929;4966.155753521982;4735.810567577396;4818.734969576707;4859.07677541266;4866.780994855169;4906.705597664151;4963.478834722447;4974.626902982219;4976.800927962841;5004.374453193351;5006.974965125151;4858.05267972742;4863.221884498464;4867.3915760529935;4870.245112007645;4915.655904086822 17:28:54 INFO - PROCESS | 16876 | |1;ext.html;573.8708790522134;579.2816907035276;583.9591228613994;587.7237698281808;593.5963544789543;26933.730662693368;42599.57400425995;43673.34489982645;43742.99999999996;43837.7808110959;40151.19697606046;40343;40568.59431405685;40587.39118913211;40630.39054414179;7709.306162445393;7882.369410447151;7886.684532618717;7891.644875980594;7892.684292628317;7743.419243556727;7833.490823096509;7852.882206766903;7867.370610351159;7874.251946065115;7777.066751989741;7831.29518343349;7847.254510821492;7869.2130786921425;7878.487898286622;7720.691172353099;7748.070231572191;7765.844683106307;7803.3367163791145;7824.843503129934;7590.544567325923;7646.617669116577;7662.463627546074;7665.846683066363;7673.53958762476;38338.23323533514;38911.22177556433;38920;38928.80535597304;38949.415758763644;3138.7489000879873;3202.6957439043254;3413.8634454622033;3509.9298014039578;3810.0284427471097;29104.708952910412;29315.267118322;29422.558661620093;29520.704792952227;30536.083917482512;3431.1250631088915;3446.7759595626203;3447.24160684649;3515.2793677296095;3535.3636345457808;186148;186517;186717;187467.06266468717;187495;52505.474945250826;52898.47101528935;52910.20634690483;52984;52998.205026924625;33484.49773253403;34204.48693269603;34391.484127738106;35912.28175436477;35919;15283.61790955235;15412.537623871302;15447.613809654624;15486.380544778309;15503.302351394213;11166.888331116746;11201.103911687045;11220.66338009861;11228.214025018333;11254.7186320341;18360.265589376275;18383.356582519817;18393.54016149607;18403.72394414085;18520.907395463208;6830.21452532965;6838.179418469816;6864.553804002824;7033.8241543960785;7081.681324340417;765.4297548326532;896.9371295015428;906.8911730592371;910.9043550427242;983.7786498038028;26950.191494255203;27783.597202685596;27968.580471292946;28078.43843123126;28199.859000704866;930.4463844012802;958.3866325551653;985.8225519406576;1011.8633984412157;1028.0644613401769;14252.287385630678;14763.194992951305;14767.852321476863;14953.925230373996;14991.32539035746;401885;404259;405921;408669;410842;33329;33559;33613.66386336106;33736.1565960853;33753;1009.9242556808268;1049.7113293844102;1175.1538891997748;1194.1282863509687;1209.4436559182875;25778.484430311662;28485.715142849134;28897.42205155927;28942;29538.409231814814;42148.789256053526;42768;42783.572164279205;42834.78582607067;42841.57158428376;298364;298467;298802;299976;300037;21541.784582153978;24779.380515487257;25255.11607093743;25668.743312566636;25776.613350799376;41253.79373103115;41318.793406032775;41618.37572436476;41781.58218417899;41923;35220.295594088486;35906.10234744152;35948.64051359453;35959.28081438409;36725;35575.64424355723;35764;36161;36428.27143457169;36438;33972;34648.82675586606;34784.65215347814;34830.65169348274;35753.284934300646;30339.393212136074;32740.345193095527;32766.67233327636;32976;33041.33917321592;24274.635880461454;24544;24736.381590460383;24959.75040249647;25102.497950041263 17:28:54 INFO - PROCESS | 16876 | |2;jquery.html;368.20100382170705;370.59049750026225;374.5729867950536;386.85879653926327;390.8768737847578;16001.919990400047;17417.21622526986;17559.47321580353;17625.82374176258;17655.91172044141;18231.45305640833;18617.534561635966;18743.531411714714;18823.152958116883;19582.902085489553;5646.435356464352;5914.408559144094;5986.161937328756;5993.910091348634;6000.939990600082;5866.589338746289;7076.964615176917;7114.430845532371;7244.529105608145;7250.782476525713;6974.163100427931;7164.462665300097;7176.820579485502;7225.638718064076;7246.855062898739;6897.137857767779;7158.2125966143685;7186.928130718678;7187.460940429489;7195.928040719605;6957.756478523278;6978.406835418996;6985.19670237924;6987.510874238806;6995.440364770806;22872;23809.64285535701;23827.76172238273;23960.64059039116;24104.879475602684;1953.7264782930401;1958.1868345302285;1985.642584334819;2088.237793205484;2701.7028126906025;14749.705005899928;14848.777268340984;15046.247687615576;15264.38942442301;15282.694346113016;1756.5959829239346;1824.644194382096;1840.631873625267;1881.2098918454146;1904.2763749775136;76355;86593.99999999937;87384.56307718484;89055;90329;16123.516294511184;16782.496525104267;16868.40960566399;17234.70739694528;17245.137743113046;29811.10566683003;29839.552406713916;29892.85053574718;30005.69994300029;30245.395092098035;8306.501609903426;8362.12197719243;8392.580370981426;8598.71019347103;8607.225349718556;6681.799546013627;6750.537280537726;6896.827579310558;7098.183708873443;7137.89293160603;8191.8771218431775;8429.74710758666;8531.146885311418;8542.829143417097;8616;3174.412733644237;3247.6265229498435;3388.3053973935284;3436.5017072524843;3449.862005519801;799.6121880887765;817.3502065857657;826.0624191542643;848.4273115646913;865.8744482050067;16041.598960026093;16641;17510.387136450165;17517.474475765746;17640.20619072119;853.5902766672032;854.5470900422786;864.291281149464;875.8379699755438;900.9414388064755;9319.114684105;9585;9717.56270967808;9915.157211636948;10055.798884022279;418363;423127;423287;425788;428655;83930.58034709787;85546.5722671395;87607.56196219106;87763;90541.54729226312;885.7918389178537;922.6632279218171;948.5115165689675;950.6150009246267;951.1249650321721;15734;16112.919435402748;16113.516594502184;16630.334786608884;16943.576410589834;37774.43338349872;37970;38573.2285354297;38830.805845970586;39062.804685976385;54794.17808732952;54836.17745733897;55963.160552592555;56181;56854.14718779139;7675.808104797425;7805.29752322271;7852;7857.253560911704;8006.479578827358;9866.475490635385;11338.24257240129;11989.940050299692;12565.18326308787;12581.87418125807;5233.947660523499;9232.446053236827;9994.10053095225;10121.392716437038;10200.38797672142;6972.825679358057;10021.599136034769;10431.478426078818;10568.418736969234;10616.8938310619;9797.559109840216;9915.702528923855;9968.302218844612;9983.400995940267;10478.109360704426;6581.868362632625;6935.098437203334;7054.435645148478;7501.174870764321;7973.681052757825;9947.452890090824;10290.176785857264;10398.27212095146;10417.583296668352;10528.894711052792 17:28:54 INFO - PROCESS | 16876 | |3;mootools.html;1268.873112688732;1362.856900025497;1412.4773833681538;1466.3474753734586;1659.5436255029858;6555.475561955044;7670.309672129507;7930;7937.920620793798;8144.389170812183;7951.960240198791;8004.4797088189225;8009.839803203932;8017.919820801791;8026.7591972240925;2213.7454192767796;2227.922022729205;2230.152542034025;2231.319447568491;2237.7090978172896;2154.2137119951185;2208.105717184535;2227.7772222777753;2232.285668586053;2232.4195709115584;2180.574787916357;2188.037263604017;2196.6814811852273;2199.175309259028;2220.455988282865;2138.7861213878564;2143.3248526714037;2144.613969485484;2145.9785402145935;2146.248812915467;2018.777934427212;2141.1970511058353;2142.4429648291557;2142.946426339354;2144.5389241313037;7940;8023.799405014863;8088.757337279891;8102.189781021851;8112.6349314281;4596.172688915994;4812.25410061441;4813.205821039559;4814.542618451242;4820.686655367425;2696.393311504896;2824.61867647867;2873.726995935383;2876.4390943765975;2876.5972763813083;840.3151680879857;854.2354592639615;858.1289990659485;1594.744840825474;1643.786307779993;10917.454127293604;10935.070519005894;11014.559417623286;11028.503717332658;11035.117190624811;4079.3676980068135;4188.162367526507;4298.505671847777;4301.41930839339;4307.267764479983;8711.128887111237;8742.431741936882;8746.781330466789;8753.956230218935;8760.649574016968;4790.568848803555;4791.856244312677;4798.520147985174;4799.232122860326;4799.640026997919;3760.9623903761158;4210.2842516772225;4423.447069116361;4458.7324760514475;4459.308807134899;3425.0409885232175;3457.083872773717;3581.982090089585;3587.5694916610173;3598.514200582888;1003.4330603209163;1045.0855501436242;1057.2916146182076;1058.767071244325;1067.5356220044305;595.6426144313377;727.3708242370311;728.4354625165433;747.5514691185354;766.7009866152205;5264.31563896691;5269.357076549904;5296.655717378358;5352.91970620441;5430.5927055471;795.0484158046504;852.6674596907087;864.9740507784651;875.1729615513278;897.2956229360052;3531.9823400882833;3583.6873576026483;3665.083729067733;3690.4833323334756;3745;9683.515824208762;10223.948880255552;10229.130523905402;10230.590776368861;10260.025297596716;10106.797864042677;10174.796504069876;10193.0316619921;10193.388396696222;10208.642697505551;7488.887666685004;7574.886376704354;7612.3148916597775;7618.314351708373;7642.121156067013;5327.413984461784;5371.113766228685;5482.259894914295;5526.226328313959;5586.078297080936;8878.689245876363;9083.45499270046;9147.039560846282;9342.112499312554;9432.339736218673;9210.493422861538;9348.45598158283;9353.579088941151;9438.905610944077;9440;6796.252412234551;6897.172339319314;6966.756163534252;7000.61496617691;7088.929110709033;7370.668319925723;7447;7462.104547454123;7477.70089196426;7482.2517748224745;6755.560888542229;6822.624755638488;6869.416099631588;6899.517033807585;7179.353858152583;6606.306337834458;6640.269570347161;6720.899186512304;6725.529212955046;6935.306469353024;6409.391107844747;6449.516286278454;6478.125453063776;6490.091387205701;6497.772577959938;4597.747123908217;4681.789319480564;4740.087842183203;4742.952570474389;4770.6183505318795;4507.143642707875;4620.422447194101;4620.5841474266135;4692.460367057832;4769.189237829508 17:28:54 INFO - PROCESS | 16876 | |4;prototype.html;291.2296974502441;294.5463985462388;299.31307648945676;301.78120862374766;302.5401389887373;4828.56542911138;4840.419149702041;4846.273059041146;4857.514248575149;4867.2455769355765;4739.218029025215;4739.786709598067;4756.073790115009;4791.688540244891;4793.880152996177;3552.1829979104823;3649.5073165122767;3689.8930320903755;3716.8884933451905;3764.228333191703;3739.830898079121;3752.9624703752884;3756.2863056019405;3761.5298087739034;3764.3224219640456;3717.925641487169;3726.347889119407;3732.701383889282;3733.328000959826;3742.9438558421643;3520.295940811835;3591.964080359202;3699.3341198584244;3724.9068773280615;3733.925321493582;3295.2585668224697;3301.125201821519;3306.9834650826833;3309.3050459403553;3312.2381852173894;4655.767211639439;4658.883527911829;4663.183942809995;4663.976680116578;4668.346431499593;4138.565450627701;4142.565030671796;4198.349255865315;4259.637930775888;4270.743755374688;4908.803647854082;4920.188168952119;4921.483244259372;4932.136876046678;4938.135826230396;3534.8967364418386;3562.9643703562892;3565.6790888820133;3579.874704385334;3590.1024743814046;4983.6760610560195;5155.510226528474;5188.610854185951;5192.221166824968;5195.298634684307;3640.0899775056237;3645.7968870273276;3679.1170119171206;3682.2451397463456;3687.2809802088336;3724.1062145084984;3727.2172843702583;3730.421784623388;3736.9626303736613;3746.7002639788752;4209.5790420957655;4243.5119961204855;4247.32042873145;4249.617534421917;4251.426057482262;4853.684510506806;4968.652194346361;4997.525235102659;5006.4743201964;5021.72380519075;1254.4919307680404;1273.961781146567;1275.4069357748692;1276.6616846535676;1279.4498365702837;836.8284501677142;837.6272558711315;854.4104567848165;855.3371137368465;872.2803686958284;4350.630196433275;4385.51759306476;4387.5393083726385;4388.341748737651;4391.978040109779;5079.822206222764;5083.822066227664;5100.38795344561;5107.821226257063;5124.180131178993;4203.684723645678;4376.365427013129;4376.387305777193;4376.956230437719;4378.233809083397;2694.609281654149;2694.797890158246;2714.267147870064;2720.183944816547;2722.237773423405;4750.714957102585;4769.546893045155;4769.856904292877;4784.397226929018;4787.904241915142;5049.368828896388;5186.014657215117;5192.844214673491;5204.9739751301;5220.582353411718;4763.73799441034;4783.473817880031;4785.569298763128;4795.736234507136;4796.640251981115;5087.974560127176;5094.719790411563;5098.337216161875;5102.336696229467;5105.719185444687;4830.2513110467935;4973.358791598692;5010.248462730619;5020.146575082172;5032.144535428913;4772.928406073981;4775.164346239464;4780.020095880405;4786.44955830084;4791.257355109963;3633.237020225782;3639.5450568678916;3640.9635903641683;3669.266146770603;3677.7241706871555;4886.315915771724;5061.417936937152;5067;5072.097963263776;5087.669301495391;4942.579880710036;4951.282064100757;4954.727489987941;4962;4962.6774259673;4947.802087916443;4947.886725486736;4951.257311403318;4956.454789973172;4972.453030166751;4739.454962679336;4865.878353041061;4870.659053866196;4880.145974454527;4881.80472781099;4864.221724524059;4952.059108769322;5026.44709082008;5082.593392528515;5114.156164233009;4934.284528743384;4954.083494553519;4968.3292755479;4969.707875952351;4971.130052240916 17:28:54 INFO - PROCESS | 16876 | |5;yui.html;600.8107446154459;623.1929651101823;630.501903496238;637.7289651897945;651.4853265919924;12749.872501274984;13567.796483052762;14049.15705057696;14072.929635351835;14249.928750356234;13309.600711978655;13453.730925381511;13482;13494.190348579092;13497.190168589892;627.8053803320985;773.4237992695449;790.9841803163933;791.6398038892319;792.3304807437706;654.2214764430313;660.9669516524178;661.8907880199786;663.0385940386435;741.2365263778318;821.650798410673;832.0514613340796;837.9748607541784;838.681301105579;839.1314988986401;833.2833762963846;833.4707460762398;833.829065041665;833.9332853371716;834.1991687979547;487.70250147410053;570.8858228354304;605.5458406195354;605.9333473317931;606.1513880567242;13524.729505409936;13604.659883502893;14045.227512486912;14058.718825623533;14074.648133796634;12797.552085676956;12855.935720321431;13000.479980800852;13315.93472522196;13655.522056727967;9587.90412095877;9805.754856128582;11075.612353567667;11230.213885028052;11259.21185517014;3487.7209823214334;3511.438169892805;3576.481410195507;3635.581908080578;3648.41625339947;61578.69210653918;63424;64957;65229;66317.6736465268;10395.84406233907;10398.584056637801;10412.502541872649;10468.162546996222;10630.73423164427;18903;19038.714419283722;19073.2370705173;19096.331628393218;19108.426747197605;6618.30507796684;6738.696758645872;6779.898301525481;6812.420944219797;6888.173419189729;3548.911277218039;3647.708183345326;3666.3217304798163;3690.7601005935066;3766.3597188478025;2717.660292463442;2774.9861250693616;2795.3011747063233;2797.8461184634634;2799.1322689966178;462.098907131089;466.8809453589381;479.7049814364141;480.9278608208797;487.76343473415363;452.73062527795906;465.4763391184917;501.2105933155222;537.4310794402761;552.9612927095145;8646.783830404165;8719.618142238038;8823.205911467998;8828.161324674145;8988.46069235848;534.2520471340077;605.5639939243738;610.1610285856947;615.9969200153971;630.0863747566048;3848.4990853567133;4021.356582946773;4083.7549747015273;4199.139176468817;4202.159568086395;93793;94712;95729.5213523928;96713.51643241738;97885;48782.75608622005;59336.40663593309;74444;86316.56841715751;86968.56515717508;72761.2723872765;73284.63357683178;78960.70912554329;79825;81288.18711812925;7791.961040194763;7849.136594974662;7898.605069746604;8118.878216826634;8128.593570321342;42909.785451072545;43941.78029109834;44391.77804110959;44443.77778111089;44787.55212447834;60095.699521502116;64197;64367.67816161077;64369;65746.34253657403;9441.52792360393;9684.85472717924;9867.16129129032;9941.552630131517;10039.397636141855;11652.126090543074;11718.472668730099;11757.882421175678;11768.293902365886;11852;10768.19238557127;10981.670549883516;10996.340219586851;11142.832857507306;11638.941805291259;9601.32790704672;10354.326968747007;10547.525361358605;12012.519499220283;12113.394330283274;11634.243774154653;11679.76640467203;11884.46519906589;12105.189509035888;12551.93724031374;9861.211103111877;9910.801783964136;9998.200143988319;10329.896701032894;10751.892481075089;9602.421514840862;10231.232657550863;10298.691039268833;10691.625793097515;10739.785204296026 17:28:54 INFO - PROCESS | 16876 | __end_tp_report 17:28:54 INFO - PROCESS | 16876 | __start_cc_report 17:28:54 INFO - PROCESS | 16876 | _x_x_mozilla_cycle_collect,921 17:28:54 INFO - PROCESS | 16876 | __end_cc_report 17:28:54 INFO - PROCESS | 16876 | __startTimestamp1469579334546__endTimestamp 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | ------- Summary: start ------- 17:28:54 INFO - PROCESS | 16876 | Number of tests: 6 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#0] dojo.html Cycles:165 Average:4694.23 Median:4818.28 stddev:487.70 (10.1%) stddev-sans-first:461.33 17:28:54 INFO - PROCESS | 16876 | Values: 2622.7 2624.0 2656.9 2671.1 2674.1 4578.6 4645.8 4723.5 4760.5 4794.0 4689.0 4699.8 4706.0 4746.6 4746.8 4361.6 4387.2 4417.5 4425.6 4488.7 4404.4 4451.2 4469.1 4483.4 4524.6 4289.3 4330.1 4359.0 4391.9 4398.2 4253.9 4294.2 4294.7 4301.6 4368.8 4302.1 4306.3 4315.3 4343.7 4354.5 4636.9 4664.1 4679.9 4716.8 4742.5 4991.4 5017.3 5048.8 5079.5 5135.4 5083.8 5091.7 5118.8 5137.5 5142.0 4600.4 4743.0 4780.5 4785.1 4786.0 5154.7 5161.6 5194.7 5254.1 5259.8 5002.0 5012.3 5050.7 5052.1 5055.7 4909.1 5066.1 5126.9 5128.4 5137.6 4744.4 4967.8 4989.7 5068.0 5115.6 5042.0 5042.1 5042.9 5045.6 5084.3 4214.8 4360.2 4366.8 4367.4 4415.6 3702.3 3786.0 3823.1 3860.7 3906.1 4354.2 4379.0 4380.4 4381.1 4424.7 5137.7 5143.8 5145.8 5147.5 5189.7 4264.6 4334.7 4367.7 4381.9 4431.1 4657.8 4661.9 4676.9 4692.1 4697.7 4813.4 4818.3 4819.3 4829.6 4861.2 4964.7 5030.6 5082.1 5140.3 5149.4 4740.3 4762.9 4764.8 4803.1 4818.3 5009.6 5011.7 5033.7 5035.5 5081.3 4900.9 4999.5 5012.2 5097.9 5154.4 4924.1 4928.8 4939.5 4958.9 4962.4 4905.1 4906.6 4915.2 4918.3 4966.2 4735.8 4818.7 4859.1 4866.8 4906.7 4963.5 4974.6 4976.8 5004.4 5007.0 4858.1 4863.2 4867.4 4870.2 4915.7 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#1] ext.html Cycles:180 Average:44655.90 Median:35664.46 stddev:82051.20 (230.1%) stddev-sans-first:82214.62 17:28:54 INFO - PROCESS | 16876 | Values: 573.9 579.3 584.0 587.7 593.6 26933.7 42599.6 43673.3 43743.0 43837.8 40151.2 40343.0 40568.6 40587.4 40630.4 7709.3 7882.4 7886.7 7891.6 7892.7 7743.4 7833.5 7852.9 7867.4 7874.3 7777.1 7831.3 7847.3 7869.2 7878.5 7720.7 7748.1 7765.8 7803.3 7824.8 7590.5 7646.6 7662.5 7665.8 7673.5 38338.2 38911.2 38920.0 38928.8 38949.4 3138.7 3202.7 3413.9 3509.9 3810.0 29104.7 29315.3 29422.6 29520.7 30536.1 3431.1 3446.8 3447.2 3515.3 3535.4 186148.0 186517.0 186717.0 187467.1 187495.0 52505.5 52898.5 52910.2 52984.0 52998.2 33484.5 34204.5 34391.5 35912.3 35919.0 15283.6 15412.5 15447.6 15486.4 15503.3 11166.9 11201.1 11220.7 11228.2 11254.7 18360.3 18383.4 18393.5 18403.7 18520.9 6830.2 6838.2 6864.6 7033.8 7081.7 765.4 896.9 906.9 910.9 983.8 26950.2 27783.6 27968.6 28078.4 28199.9 930.4 958.4 985.8 1011.9 1028.1 14252.3 14763.2 14767.9 14953.9 14991.3 401885.0 404259.0 405921.0 408669.0 410842.0 33329.0 33559.0 33613.7 33736.2 33753.0 1009.9 1049.7 1175.2 1194.1 1209.4 25778.5 28485.7 28897.4 28942.0 29538.4 42148.8 42768.0 42783.6 42834.8 42841.6 298364.0 298467.0 298802.0 299976.0 300037.0 21541.8 24779.4 25255.1 25668.7 25776.6 41253.8 41318.8 41618.4 41781.6 41923.0 35220.3 35906.1 35948.6 35959.3 36725.0 35575.6 35764.0 36161.0 36428.3 36438.0 33972.0 34648.8 34784.7 34830.7 35753.3 30339.4 32740.3 32766.7 32976.0 33041.3 24274.6 24544.0 24736.4 24959.8 25102.5 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#2] jquery.html Cycles:180 Average:27492.38 Median:30913.72 stddev:70192.67 (227.1%) stddev-sans-first:70360.03 17:28:54 INFO - PROCESS | 16876 | Values: 368.2 370.6 374.6 386.9 390.9 16001.9 17417.2 17559.5 17625.8 17655.9 18231.5 18617.5 18743.5 18823.2 19582.9 5646.4 5914.4 5986.2 5993.9 6000.9 5866.6 7077.0 7114.4 7244.5 7250.8 6974.2 7164.5 7176.8 7225.6 7246.9 6897.1 7158.2 7186.9 7187.5 7195.9 6957.8 6978.4 6985.2 6987.5 6995.4 22872.0 23809.6 23827.8 23960.6 24104.9 1953.7 1958.2 1985.6 2088.2 2701.7 14749.7 14848.8 15046.2 15264.4 15282.7 1756.6 1824.6 1840.6 1881.2 1904.3 76355.0 86594.0 87384.6 89055.0 90329.0 16123.5 16782.5 16868.4 17234.7 17245.1 29811.1 29839.6 29892.9 30005.7 30245.4 8306.5 8362.1 8392.6 8598.7 8607.2 6681.8 6750.5 6896.8 7098.2 7137.9 8191.9 8429.7 8531.1 8542.8 8616.0 3174.4 3247.6 3388.3 3436.5 3449.9 799.6 817.4 826.1 848.4 865.9 16041.6 16641.0 17510.4 17517.5 17640.2 853.6 854.5 864.3 875.8 900.9 9319.1 9585.0 9717.6 9915.2 10055.8 418363.0 423127.0 423287.0 425788.0 428655.0 83930.6 85546.6 87607.6 87763.0 90541.5 885.8 922.7 948.5 950.6 951.1 15734.0 16112.9 16113.5 16630.3 16943.6 37774.4 37970.0 38573.2 38830.8 39062.8 54794.2 54836.2 55963.2 56181.0 56854.1 7675.8 7805.3 7852.0 7857.3 8006.5 9866.5 11338.2 11989.9 12565.2 12581.9 5233.9 9232.4 9994.1 10121.4 10200.4 6972.8 10021.6 10431.5 10568.4 10616.9 9797.6 9915.7 9968.3 9983.4 10478.1 6581.9 6935.1 7054.4 7501.2 7973.7 9947.5 10290.2 10398.3 10417.6 10528.9 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#3] mootools.html Cycles:180 Average:5240.38 Median:4799.44 stddev:2978.09 (62.1%) stddev-sans-first:2971.49 17:28:54 INFO - PROCESS | 16876 | Values: 1268.9 1362.9 1412.5 1466.3 1659.5 6555.5 7670.3 7930.0 7937.9 8144.4 7952.0 8004.5 8009.8 8017.9 8026.8 2213.7 2227.9 2230.2 2231.3 2237.7 2154.2 2208.1 2227.8 2232.3 2232.4 2180.6 2188.0 2196.7 2199.2 2220.5 2138.8 2143.3 2144.6 2146.0 2146.2 2018.8 2141.2 2142.4 2142.9 2144.5 7940.0 8023.8 8088.8 8102.2 8112.6 4596.2 4812.3 4813.2 4814.5 4820.7 2696.4 2824.6 2873.7 2876.4 2876.6 840.3 854.2 858.1 1594.7 1643.8 10917.5 10935.1 11014.6 11028.5 11035.1 4079.4 4188.2 4298.5 4301.4 4307.3 8711.1 8742.4 8746.8 8754.0 8760.6 4790.6 4791.9 4798.5 4799.2 4799.6 3761.0 4210.3 4423.4 4458.7 4459.3 3425.0 3457.1 3582.0 3587.6 3598.5 1003.4 1045.1 1057.3 1058.8 1067.5 595.6 727.4 728.4 747.6 766.7 5264.3 5269.4 5296.7 5352.9 5430.6 795.0 852.7 865.0 875.2 897.3 3532.0 3583.7 3665.1 3690.5 3745.0 9683.5 10223.9 10229.1 10230.6 10260.0 10106.8 10174.8 10193.0 10193.4 10208.6 7488.9 7574.9 7612.3 7618.3 7642.1 5327.4 5371.1 5482.3 5526.2 5586.1 8878.7 9083.5 9147.0 9342.1 9432.3 9210.5 9348.5 9353.6 9438.9 9440.0 6796.3 6897.2 6966.8 7000.6 7088.9 7370.7 7447.0 7462.1 7477.7 7482.3 6755.6 6822.6 6869.4 6899.5 7179.4 6606.3 6640.3 6720.9 6725.5 6935.3 6409.4 6449.5 6478.1 6490.1 6497.8 4597.7 4681.8 4740.1 4743.0 4770.6 4507.1 4620.4 4620.6 4692.5 4769.2 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#4] prototype.html Cycles:180 Average:4132.90 Median:4766.64 stddev:1191.12 (25.0%) stddev-sans-first:1159.04 17:28:54 INFO - PROCESS | 16876 | Values: 291.2 294.5 299.3 301.8 302.5 4828.6 4840.4 4846.3 4857.5 4867.2 4739.2 4739.8 4756.1 4791.7 4793.9 3552.2 3649.5 3689.9 3716.9 3764.2 3739.8 3753.0 3756.3 3761.5 3764.3 3717.9 3726.3 3732.7 3733.3 3742.9 3520.3 3592.0 3699.3 3724.9 3733.9 3295.3 3301.1 3307.0 3309.3 3312.2 4655.8 4658.9 4663.2 4664.0 4668.3 4138.6 4142.6 4198.3 4259.6 4270.7 4908.8 4920.2 4921.5 4932.1 4938.1 3534.9 3563.0 3565.7 3579.9 3590.1 4983.7 5155.5 5188.6 5192.2 5195.3 3640.1 3645.8 3679.1 3682.2 3687.3 3724.1 3727.2 3730.4 3737.0 3746.7 4209.6 4243.5 4247.3 4249.6 4251.4 4853.7 4968.7 4997.5 5006.5 5021.7 1254.5 1274.0 1275.4 1276.7 1279.4 836.8 837.6 854.4 855.3 872.3 4350.6 4385.5 4387.5 4388.3 4392.0 5079.8 5083.8 5100.4 5107.8 5124.2 4203.7 4376.4 4376.4 4377.0 4378.2 2694.6 2694.8 2714.3 2720.2 2722.2 4750.7 4769.5 4769.9 4784.4 4787.9 5049.4 5186.0 5192.8 5205.0 5220.6 4763.7 4783.5 4785.6 4795.7 4796.6 5088.0 5094.7 5098.3 5102.3 5105.7 4830.3 4973.4 5010.2 5020.1 5032.1 4772.9 4775.2 4780.0 4786.4 4791.3 3633.2 3639.5 3641.0 3669.3 3677.7 4886.3 5061.4 5067.0 5072.1 5087.7 4942.6 4951.3 4954.7 4962.0 4962.7 4947.8 4947.9 4951.3 4956.5 4972.5 4739.5 4865.9 4870.7 4880.1 4881.8 4864.2 4952.1 5026.4 5082.6 5114.2 4934.3 4954.1 4968.3 4969.7 4971.1 17:28:54 INFO - PROCESS | 16876 | 17:28:54 INFO - PROCESS | 16876 | [#5] yui.html Cycles:180 Average:17502.79 Median:487.73 stddev:24763.81 (5077.3%) stddev-sans-first:24800.75 17:28:54 INFO - PROCESS | 16876 | Values: 600.8 623.2 630.5 637.7 651.5 12749.9 13567.8 14049.2 14072.9 14249.9 13309.6 13453.7 13482.0 13494.2 13497.2 627.8 773.4 791.0 791.6 792.3 654.2 661.0 661.9 663.0 741.2 821.7 832.1 838.0 838.7 839.1 833.3 833.5 833.8 833.9 834.2 487.7 570.9 605.5 605.9 606.2 13524.7 13604.7 14045.2 14058.7 14074.6 12797.6 12855.9 13000.5 13315.9 13655.5 9587.9 9805.8 11075.6 11230.2 11259.2 3487.7 3511.4 3576.5 3635.6 3648.4 61578.7 63424.0 64957.0 65229.0 66317.7 10395.8 10398.6 10412.5 10468.2 10630.7 18903.0 19038.7 19073.2 19096.3 19108.4 6618.3 6738.7 6779.9 6812.4 6888.2 3548.9 3647.7 3666.3 3690.8 3766.4 2717.7 2775.0 2795.3 2797.8 2799.1 462.1 466.9 479.7 480.9 487.8 452.7 465.5 501.2 537.4 553.0 8646.8 8719.6 8823.2 8828.2 8988.5 534.3 605.6 610.2 616.0 630.1 3848.5 4021.4 4083.8 4199.1 4202.2 93793.0 94712.0 95729.5 96713.5 97885.0 48782.8 59336.4 74444.0 86316.6 86968.6 72761.3 73284.6 78960.7 79825.0 81288.2 7792.0 7849.1 7898.6 8118.9 8128.6 42909.8 43941.8 44391.8 44443.8 44787.6 60095.7 64197.0 64367.7 64369.0 65746.3 9441.5 9684.9 9867.2 9941.6 10039.4 11652.1 11718.5 11757.9 11768.3 11852.0 10768.2 10981.7 10996.3 11142.8 11638.9 9601.3 10354.3 10547.5 12012.5 12113.4 11634.2 11679.8 11884.5 12105.2 12551.9 9861.2 9910.8 9998.2 10329.9 10751.9 9602.4 10231.2 10298.7 10691.6 10739.8 17:28:54 INFO - PROCESS | 16876 | -------- Summary: end -------- 17:28:54 INFO - PROCESS | 16876 | 17:28:55 INFO - TEST-INFO | 16876: exit 0 17:28:55 INFO - TEST-OK | dromaeo_css | took 1119701ms 17:28:55 INFO - TEST-START | kraken 17:28:55 INFO - operating with platform_type : linux_ 17:28:55 INFO - Initialising browser for kraken test... 17:28:55 INFO - TEST-INFO | started process 17064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAPq31E/profile http://localhost:34998/getInfo.html) 17:28:58 INFO - PROCESS | 17064 | JavaScript error: , line 0: uncaught exception: undefined 17:28:59 INFO - PROCESS | 17064 | __metrics Screen width/height:1600/1200 17:28:59 INFO - PROCESS | 17064 | colorDepth:24 17:28:59 INFO - PROCESS | 17064 | Browser inner width/height: 1024/697 17:28:59 INFO - PROCESS | 17064 | __metrics 17:29:00 INFO - PROCESS | 17064 | 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" 17:29:00 INFO - PROCESS | 17064 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:00 INFO - PROCESS | 17064 | console.error: PushService: 17:29:00 INFO - PROCESS | 17064 | stateChangeProcessEnqueue: Error transitioning state 17:29:00 INFO - PROCESS | 17064 | UnknownError 17:29:01 INFO - TEST-INFO | 17064: exit 0 17:29:01 INFO - Browser initialized. 17:29:01 INFO - Running cycle 1/1 for kraken test... 17:29:01 INFO - TEST-INFO | started process 17143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAPq31E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:13 INFO - PROCESS | 17143 | RSS: Main: 159158272 17:29:13 INFO - PROCESS | 17143 | 17:29:15 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34998/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:16 INFO - PROCESS | 17143 | RSS: Main: 215629824 17:29:16 INFO - PROCESS | 17143 | 17:29:19 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34998/tests/kraken/driver.html?testName=audio-dft) 17:29:20 INFO - PROCESS | 17143 | RSS: Main: 193171456 17:29:20 INFO - PROCESS | 17143 | 17:29:23 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34998/tests/kraken/driver.html?testName=audio-fft) 17:29:24 INFO - PROCESS | 17143 | RSS: Main: 273362944 17:29:24 INFO - PROCESS | 17143 | 17:29:26 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34998/tests/kraken/driver.html?testName=audio-oscillator) 17:29:26 INFO - PROCESS | 17143 | RSS: Main: 181514240 17:29:26 INFO - PROCESS | 17143 | 17:29:29 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:29 INFO - PROCESS | 17143 | RSS: Main: 186826752 17:29:29 INFO - PROCESS | 17143 | 17:29:32 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34998/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:33 INFO - PROCESS | 17143 | RSS: Main: 223166464 17:29:33 INFO - PROCESS | 17143 | 17:29:36 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34998/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:37 INFO - PROCESS | 17143 | RSS: Main: 216666112 17:29:37 INFO - PROCESS | 17143 | 17:29:40 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34998/tests/kraken/driver.html?testName=json-parse-financial) 17:29:41 INFO - PROCESS | 17143 | RSS: Main: 219860992 17:29:41 INFO - PROCESS | 17143 | 17:29:42 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:43 INFO - PROCESS | 17143 | RSS: Main: 185659392 17:29:43 INFO - PROCESS | 17143 | 17:29:45 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:45 INFO - PROCESS | 17143 | RSS: Main: 192315392 17:29:45 INFO - PROCESS | 17143 | 17:29:47 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:48 INFO - PROCESS | 17143 | RSS: Main: 194449408 17:29:48 INFO - PROCESS | 17143 | 17:29:51 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:52 INFO - PROCESS | 17143 | RSS: Main: 191086592 17:29:52 INFO - PROCESS | 17143 | 17:29:54 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:55 INFO - PROCESS | 17143 | RSS: Main: 193961984 17:29:55 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:34998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34998/tests/kraken/driver.html?testName=ai-astar) 17:29:57 INFO - PROCESS | 17143 | RSS: Main: 244506624 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | __start_tp_report 17:29:57 INFO - PROCESS | 17143 | _x_x_mozilla_page_load 17:29:57 INFO - PROCESS | 17143 | _x_x_mozilla_page_load_details 17:29:57 INFO - PROCESS | 17143 | |i|pagename|runs| 17:29:57 INFO - PROCESS | 17143 | |0;ai-astar;107;115;115;114;114;115;113;114;114;114 17:29:57 INFO - PROCESS | 17143 | |1;audio-beat-detection;149;126;125;191;130;131;145;123;194;129 17:29:57 INFO - PROCESS | 17143 | |2;audio-dft;160;162;164;163;161;161;162;160;161;159 17:29:57 INFO - PROCESS | 17143 | |3;audio-fft;74;76;76;122;79;77;75;77;100;76 17:29:57 INFO - PROCESS | 17143 | |4;audio-oscillator;86;86;129;85;85;86;113;84;86;133 17:29:57 INFO - PROCESS | 17143 | |5;imaging-gaussian-blur;117;117;117;116;118;118;119;117;116;117 17:29:57 INFO - PROCESS | 17143 | |6;imaging-darkroom;146;148;146;146;146;146;147;146;147;145 17:29:57 INFO - PROCESS | 17143 | |7;imaging-desaturate;95;96;94;95;95;94;94;95;95;95 17:29:57 INFO - PROCESS | 17143 | |8;json-parse-financial;61;62;63;63;65;62;64;62;62;61 17:29:57 INFO - PROCESS | 17143 | |9;json-stringify-tinderbox;64;65;65;64;66;65;65;66;65;66 17:29:57 INFO - PROCESS | 17143 | |10;stanford-crypto-aes;79;80;80;80;81;79;79;85;79;82 17:29:57 INFO - PROCESS | 17143 | |11;stanford-crypto-ccm;140;131;130;137;131;133;132;134;174;131 17:29:57 INFO - PROCESS | 17143 | |12;stanford-crypto-pbkdf2;165;168;166;170;166;165;168;169;166;168 17:29:57 INFO - PROCESS | 17143 | |13;stanford-crypto-sha256-iterative;69;67;67;67;71;69;67;68;66;66 17:29:57 INFO - PROCESS | 17143 | __end_tp_report 17:29:57 INFO - PROCESS | 17143 | __start_cc_report 17:29:57 INFO - PROCESS | 17143 | _x_x_mozilla_cycle_collect,1943 17:29:57 INFO - PROCESS | 17143 | __end_cc_report 17:29:57 INFO - PROCESS | 17143 | __startTimestamp1469579397510__endTimestamp 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | ------- Summary: start ------- 17:29:57 INFO - PROCESS | 17143 | Number of tests: 14 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.37 (2.1%) stddev-sans-first:0.67 17:29:57 INFO - PROCESS | 17143 | Values: 107.0 115.0 115.0 114.0 114.0 115.0 113.0 114.0 114.0 114.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:138.00 stddev:26.77 (19.4%) stddev-sans-first:28.34 17:29:57 INFO - PROCESS | 17143 | Values: 149.0 126.0 125.0 191.0 130.0 131.0 145.0 123.0 194.0 129.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 17:29:57 INFO - PROCESS | 17143 | Values: 160.0 162.0 164.0 163.0 161.0 161.0 162.0 160.0 161.0 159.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.60 (20.5%) stddev-sans-first:16.18 17:29:57 INFO - PROCESS | 17143 | Values: 74.0 76.0 76.0 122.0 79.0 77.0 75.0 77.0 100.0 76.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.50 stddev:19.77 (23.1%) stddev-sans-first:20.54 17:29:57 INFO - PROCESS | 17143 | Values: 86.0 86.0 129.0 85.0 85.0 86.0 113.0 84.0 86.0 133.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:29:57 INFO - PROCESS | 17143 | Values: 117.0 117.0 117.0 116.0 118.0 118.0 119.0 117.0 116.0 117.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 17:29:57 INFO - PROCESS | 17143 | Values: 146.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:29:57 INFO - PROCESS | 17143 | Values: 95.0 96.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:1.27 (2.0%) stddev-sans-first:1.22 17:29:57 INFO - PROCESS | 17143 | Values: 61.0 62.0 63.0 63.0 65.0 62.0 64.0 62.0 62.0 61.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 17:29:57 INFO - PROCESS | 17143 | Values: 64.0 65.0 65.0 64.0 66.0 65.0 65.0 66.0 65.0 66.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.90 (2.4%) stddev-sans-first:1.94 17:29:57 INFO - PROCESS | 17143 | Values: 79.0 80.0 80.0 80.0 81.0 79.0 79.0 85.0 79.0 82.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:133.50 stddev:13.27 (9.9%) stddev-sans-first:14.04 17:29:57 INFO - PROCESS | 17143 | Values: 140.0 131.0 130.0 137.0 131.0 133.0 132.0 134.0 174.0 131.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:1.73 (1.0%) stddev-sans-first:1.66 17:29:57 INFO - PROCESS | 17143 | Values: 165.0 168.0 166.0 170.0 166.0 165.0 168.0 169.0 166.0 168.0 17:29:57 INFO - PROCESS | 17143 | 17:29:57 INFO - PROCESS | 17143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.59 17:29:57 INFO - PROCESS | 17143 | Values: 69.0 67.0 67.0 67.0 71.0 69.0 67.0 68.0 66.0 66.0 17:29:57 INFO - PROCESS | 17143 | -------- Summary: end -------- 17:29:57 INFO - PROCESS | 17143 | 17:29:58 INFO - TEST-INFO | 17143: exit 0 17:29:58 INFO - TEST-OK | kraken | took 63310ms 17:29:58 INFO - SUITE-END | took 1183s 17:29:59 INFO - Completed test suite (00:19:43) 17:29:59 INFO - javascript benchmark 17:29:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.6852777666677, 2624.0, 2656.853873036983, 2671.0517766193, 2674.1309074550777, 4578.633709303256, 4645.814167433307, 4723.456802467717, 4760.547747963947, 4794.017226468574, 4689.0, 4699.835505757299, 4705.976470117653, 4746.620270378378, 4746.762661866902, 4361.6292615127595, 4387.210302145612, 4417.491988421324, 4425.557444255564, 4488.685791994561, 4404.383386325917, 4451.221036318631, 4469.08383781324, 4483.372327874084, 4524.6380289576755, 4289.270823959934, 4330.069035157425, 4359.0, 4391.934120988188, 4398.230309695822, 4253.936190957138, 4294.184105020036, 4294.720843145185, 4301.634361079312, 4368.825246990116, 4302.053548219386, 4306.267934451151, 4315.287977483711, 4343.717658352229, 4354.521002689701, 4636.907261854744, 4664.137134630104, 4679.9298010529865, 4716.787744551503, 4742.50203728607, 4991.351124353847, 5017.2724954881705, 5048.823291184827, 5079.492050794928, 5135.35808023997, 5083.847484575469, 5091.745412729349, 5118.769655365518, 5137.486251374833, 5142.0, 4600.447946246405, 4742.999999999965, 4780.545848144421, 4785.090832741837, 4785.95214047862, 5154.664946778447, 5161.612879034013, 5194.740262986836, 5254.054270231319, 5259.8422047338645, 5001.974990125026, 5012.348394708664, 5050.671706339076, 5052.090623687772, 5055.747212639427, 4909.091818013679, 5066.088104141216, 5126.92309615356, 5128.384593848762, 5137.588992880561, 4744.359511465908, 4967.751612419437, 4989.725565093955, 5068.0370729562, 5115.616328775282, 5041.974790126099, 5042.092423363756, 5042.924356134661, 5045.571126454219, 5084.262781896604, 4214.810333534998, 4360.171567402183, 4366.8034938427845, 4367.366731823868, 4415.602595766396, 3702.278055779151, 3786.0, 3823.1397935464856, 3860.7104467164513, 3906.140649057203, 4354.172707185625, 4378.956210437918, 4380.386745855582, 4381.058072514425, 4424.6681498887065, 5137.743112844343, 5143.7685304161405, 5145.845624631267, 5147.459516750762, 5189.714565698923, 4264.637505812041, 4334.718243314174, 4367.694261401735, 4381.890452738707, 4431.135928493977, 4657.790399432034, 4661.860144195612, 4676.929846052312, 4692.061587682477, 4697.671163018625, 4813.3983252093485, 4818.349522814376, 4819.277108433763, 4829.5653391194965, 4861.173600487996, 4964.702117872939, 5030.647854650139, 5082.085224659597, 5140.30605868203, 5149.407818100816, 4740.336352910665, 4762.880927976828, 4764.809407623657, 4803.135435621622, 4818.277258411266, 5009.5992320615, 5011.699298042129, 5033.748312584283, 5035.521625445577, 5081.314022606901, 4900.901981960412, 4999.47505511916, 5012.22310541852, 5097.9490205098955, 5154.381474223117, 4924.089043526959, 4928.827491037797, 4939.506049395175, 4958.851234462972, 4962.429320628174, 4905.068037072945, 4906.6320025997475, 4915.238138088602, 4918.262260660929, 4966.155753521982, 4735.810567577396, 4818.734969576707, 4859.07677541266, 4866.780994855169, 4906.705597664151, 4963.478834722447, 4974.626902982219, 4976.800927962841, 5004.374453193351, 5006.974965125151, 4858.05267972742, 4863.221884498464, 4867.3915760529935, 4870.245112007645, 4915.655904086822], "value": 4663.320899202056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8708790522134, 579.2816907035276, 583.9591228613994, 587.7237698281808, 593.5963544789543, 26933.730662693368, 42599.57400425995, 43673.34489982645, 43742.99999999996, 43837.7808110959, 40151.19697606046, 40343.0, 40568.59431405685, 40587.39118913211, 40630.39054414179, 7709.306162445393, 7882.369410447151, 7886.684532618717, 7891.644875980594, 7892.684292628317, 7743.419243556727, 7833.490823096509, 7852.882206766903, 7867.370610351159, 7874.251946065115, 7777.066751989741, 7831.29518343349, 7847.254510821492, 7869.2130786921425, 7878.487898286622, 7720.691172353099, 7748.070231572191, 7765.844683106307, 7803.3367163791145, 7824.843503129934, 7590.544567325923, 7646.617669116577, 7662.463627546074, 7665.846683066363, 7673.53958762476, 38338.23323533514, 38911.22177556433, 38920.0, 38928.80535597304, 38949.415758763644, 3138.7489000879873, 3202.6957439043254, 3413.8634454622033, 3509.9298014039578, 3810.0284427471097, 29104.708952910412, 29315.267118322, 29422.558661620093, 29520.704792952227, 30536.083917482512, 3431.1250631088915, 3446.7759595626203, 3447.24160684649, 3515.2793677296095, 3535.3636345457808, 186148.0, 186517.0, 186717.0, 187467.06266468717, 187495.0, 52505.474945250826, 52898.47101528935, 52910.20634690483, 52984.0, 52998.205026924625, 33484.49773253403, 34204.48693269603, 34391.484127738106, 35912.28175436477, 35919.0, 15283.61790955235, 15412.537623871302, 15447.613809654624, 15486.380544778309, 15503.302351394213, 11166.888331116746, 11201.103911687045, 11220.66338009861, 11228.214025018333, 11254.7186320341, 18360.265589376275, 18383.356582519817, 18393.54016149607, 18403.72394414085, 18520.907395463208, 6830.21452532965, 6838.179418469816, 6864.553804002824, 7033.8241543960785, 7081.681324340417, 765.4297548326532, 896.9371295015428, 906.8911730592371, 910.9043550427242, 983.7786498038028, 26950.191494255203, 27783.597202685596, 27968.580471292946, 28078.43843123126, 28199.859000704866, 930.4463844012802, 958.3866325551653, 985.8225519406576, 1011.8633984412157, 1028.0644613401769, 14252.287385630678, 14763.194992951305, 14767.852321476863, 14953.925230373996, 14991.32539035746, 401885.0, 404259.0, 405921.0, 408669.0, 410842.0, 33329.0, 33559.0, 33613.66386336106, 33736.1565960853, 33753.0, 1009.9242556808268, 1049.7113293844102, 1175.1538891997748, 1194.1282863509687, 1209.4436559182875, 25778.484430311662, 28485.715142849134, 28897.42205155927, 28942.0, 29538.409231814814, 42148.789256053526, 42768.0, 42783.572164279205, 42834.78582607067, 42841.57158428376, 298364.0, 298467.0, 298802.0, 299976.0, 300037.0, 21541.784582153978, 24779.380515487257, 25255.11607093743, 25668.743312566636, 25776.613350799376, 41253.79373103115, 41318.793406032775, 41618.37572436476, 41781.58218417899, 41923.0, 35220.295594088486, 35906.10234744152, 35948.64051359453, 35959.28081438409, 36725.0, 35575.64424355723, 35764.0, 36161.0, 36428.27143457169, 36438.0, 33972.0, 34648.82675586606, 34784.65215347814, 34830.65169348274, 35753.284934300646, 30339.393212136074, 32740.345193095527, 32766.67233327636, 32976.0, 33041.33917321592, 24274.635880461454, 24544.0, 24736.381590460383, 24959.75040249647, 25102.497950041263], "value": 17025.75624952635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.20100382170705, 370.59049750026225, 374.5729867950536, 386.85879653926327, 390.8768737847578, 16001.919990400047, 17417.21622526986, 17559.47321580353, 17625.82374176258, 17655.91172044141, 18231.45305640833, 18617.534561635966, 18743.531411714714, 18823.152958116883, 19582.902085489553, 5646.435356464352, 5914.408559144094, 5986.161937328756, 5993.910091348634, 6000.939990600082, 5866.589338746289, 7076.964615176917, 7114.430845532371, 7244.529105608145, 7250.782476525713, 6974.163100427931, 7164.462665300097, 7176.820579485502, 7225.638718064076, 7246.855062898739, 6897.137857767779, 7158.2125966143685, 7186.928130718678, 7187.460940429489, 7195.928040719605, 6957.756478523278, 6978.406835418996, 6985.19670237924, 6987.510874238806, 6995.440364770806, 22872.0, 23809.64285535701, 23827.76172238273, 23960.64059039116, 24104.879475602684, 1953.7264782930401, 1958.1868345302285, 1985.642584334819, 2088.237793205484, 2701.7028126906025, 14749.705005899928, 14848.777268340984, 15046.247687615576, 15264.38942442301, 15282.694346113016, 1756.5959829239346, 1824.644194382096, 1840.631873625267, 1881.2098918454146, 1904.2763749775136, 76355.0, 86593.99999999937, 87384.56307718484, 89055.0, 90329.0, 16123.516294511184, 16782.496525104267, 16868.40960566399, 17234.70739694528, 17245.137743113046, 29811.10566683003, 29839.552406713916, 29892.85053574718, 30005.69994300029, 30245.395092098035, 8306.501609903426, 8362.12197719243, 8392.580370981426, 8598.71019347103, 8607.225349718556, 6681.799546013627, 6750.537280537726, 6896.827579310558, 7098.183708873443, 7137.89293160603, 8191.8771218431775, 8429.74710758666, 8531.146885311418, 8542.829143417097, 8616.0, 3174.412733644237, 3247.6265229498435, 3388.3053973935284, 3436.5017072524843, 3449.862005519801, 799.6121880887765, 817.3502065857657, 826.0624191542643, 848.4273115646913, 865.8744482050067, 16041.598960026093, 16641.0, 17510.387136450165, 17517.474475765746, 17640.20619072119, 853.5902766672032, 854.5470900422786, 864.291281149464, 875.8379699755438, 900.9414388064755, 9319.114684105, 9585.0, 9717.56270967808, 9915.157211636948, 10055.798884022279, 418363.0, 423127.0, 423287.0, 425788.0, 428655.0, 83930.58034709787, 85546.5722671395, 87607.56196219106, 87763.0, 90541.54729226312, 885.7918389178537, 922.6632279218171, 948.5115165689675, 950.6150009246267, 951.1249650321721, 15734.0, 16112.919435402748, 16113.516594502184, 16630.334786608884, 16943.576410589834, 37774.43338349872, 37970.0, 38573.2285354297, 38830.805845970586, 39062.804685976385, 54794.17808732952, 54836.17745733897, 55963.160552592555, 56181.0, 56854.14718779139, 7675.808104797425, 7805.29752322271, 7852.0, 7857.253560911704, 8006.479578827358, 9866.475490635385, 11338.24257240129, 11989.940050299692, 12565.18326308787, 12581.87418125807, 5233.947660523499, 9232.446053236827, 9994.10053095225, 10121.392716437038, 10200.38797672142, 6972.825679358057, 10021.599136034769, 10431.478426078818, 10568.418736969234, 10616.8938310619, 9797.559109840216, 9915.702528923855, 9968.302218844612, 9983.400995940267, 10478.109360704426, 6581.868362632625, 6935.098437203334, 7054.435645148478, 7501.174870764321, 7973.681052757825, 9947.452890090824, 10290.176785857264, 10398.27212095146, 10417.583296668352, 10528.894711052792], "value": 9494.477407359735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.873112688732, 1362.856900025497, 1412.4773833681538, 1466.3474753734586, 1659.5436255029858, 6555.475561955044, 7670.309672129507, 7930.0, 7937.920620793798, 8144.389170812183, 7951.960240198791, 8004.4797088189225, 8009.839803203932, 8017.919820801791, 8026.7591972240925, 2213.7454192767796, 2227.922022729205, 2230.152542034025, 2231.319447568491, 2237.7090978172896, 2154.2137119951185, 2208.105717184535, 2227.7772222777753, 2232.285668586053, 2232.4195709115584, 2180.574787916357, 2188.037263604017, 2196.6814811852273, 2199.175309259028, 2220.455988282865, 2138.7861213878564, 2143.3248526714037, 2144.613969485484, 2145.9785402145935, 2146.248812915467, 2018.777934427212, 2141.1970511058353, 2142.4429648291557, 2142.946426339354, 2144.5389241313037, 7940.0, 8023.799405014863, 8088.757337279891, 8102.189781021851, 8112.6349314281, 4596.172688915994, 4812.25410061441, 4813.205821039559, 4814.542618451242, 4820.686655367425, 2696.393311504896, 2824.61867647867, 2873.726995935383, 2876.4390943765975, 2876.5972763813083, 840.3151680879857, 854.2354592639615, 858.1289990659485, 1594.744840825474, 1643.786307779993, 10917.454127293604, 10935.070519005894, 11014.559417623286, 11028.503717332658, 11035.117190624811, 4079.3676980068135, 4188.162367526507, 4298.505671847777, 4301.41930839339, 4307.267764479983, 8711.128887111237, 8742.431741936882, 8746.781330466789, 8753.956230218935, 8760.649574016968, 4790.568848803555, 4791.856244312677, 4798.520147985174, 4799.232122860326, 4799.640026997919, 3760.9623903761158, 4210.2842516772225, 4423.447069116361, 4458.7324760514475, 4459.308807134899, 3425.0409885232175, 3457.083872773717, 3581.982090089585, 3587.5694916610173, 3598.514200582888, 1003.4330603209163, 1045.0855501436242, 1057.2916146182076, 1058.767071244325, 1067.5356220044305, 595.6426144313377, 727.3708242370311, 728.4354625165433, 747.5514691185354, 766.7009866152205, 5264.31563896691, 5269.357076549904, 5296.655717378358, 5352.91970620441, 5430.5927055471, 795.0484158046504, 852.6674596907087, 864.9740507784651, 875.1729615513278, 897.2956229360052, 3531.9823400882833, 3583.6873576026483, 3665.083729067733, 3690.4833323334756, 3745.0, 9683.515824208762, 10223.948880255552, 10229.130523905402, 10230.590776368861, 10260.025297596716, 10106.797864042677, 10174.796504069876, 10193.0316619921, 10193.388396696222, 10208.642697505551, 7488.887666685004, 7574.886376704354, 7612.3148916597775, 7618.314351708373, 7642.121156067013, 5327.413984461784, 5371.113766228685, 5482.259894914295, 5526.226328313959, 5586.078297080936, 8878.689245876363, 9083.45499270046, 9147.039560846282, 9342.112499312554, 9432.339736218673, 9210.493422861538, 9348.45598158283, 9353.579088941151, 9438.905610944077, 9440.0, 6796.252412234551, 6897.172339319314, 6966.756163534252, 7000.61496617691, 7088.929110709033, 7370.668319925723, 7447.0, 7462.104547454123, 7477.70089196426, 7482.2517748224745, 6755.560888542229, 6822.624755638488, 6869.416099631588, 6899.517033807585, 7179.353858152583, 6606.306337834458, 6640.269570347161, 6720.899186512304, 6725.529212955046, 6935.306469353024, 6409.391107844747, 6449.516286278454, 6478.125453063776, 6490.091387205701, 6497.772577959938, 4597.747123908217, 4681.789319480564, 4740.087842183203, 4742.952570474389, 4770.6183505318795, 4507.143642707875, 4620.422447194101, 4620.5841474266135, 4692.460367057832, 4769.189237829508], "value": 4188.046805568119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2296974502441, 294.5463985462388, 299.31307648945676, 301.78120862374766, 302.5401389887373, 4828.56542911138, 4840.419149702041, 4846.273059041146, 4857.514248575149, 4867.2455769355765, 4739.218029025215, 4739.786709598067, 4756.073790115009, 4791.688540244891, 4793.880152996177, 3552.1829979104823, 3649.5073165122767, 3689.8930320903755, 3716.8884933451905, 3764.228333191703, 3739.830898079121, 3752.9624703752884, 3756.2863056019405, 3761.5298087739034, 3764.3224219640456, 3717.925641487169, 3726.347889119407, 3732.701383889282, 3733.328000959826, 3742.9438558421643, 3520.295940811835, 3591.964080359202, 3699.3341198584244, 3724.9068773280615, 3733.925321493582, 3295.2585668224697, 3301.125201821519, 3306.9834650826833, 3309.3050459403553, 3312.2381852173894, 4655.767211639439, 4658.883527911829, 4663.183942809995, 4663.976680116578, 4668.346431499593, 4138.565450627701, 4142.565030671796, 4198.349255865315, 4259.637930775888, 4270.743755374688, 4908.803647854082, 4920.188168952119, 4921.483244259372, 4932.136876046678, 4938.135826230396, 3534.8967364418386, 3562.9643703562892, 3565.6790888820133, 3579.874704385334, 3590.1024743814046, 4983.6760610560195, 5155.510226528474, 5188.610854185951, 5192.221166824968, 5195.298634684307, 3640.0899775056237, 3645.7968870273276, 3679.1170119171206, 3682.2451397463456, 3687.2809802088336, 3724.1062145084984, 3727.2172843702583, 3730.421784623388, 3736.9626303736613, 3746.7002639788752, 4209.5790420957655, 4243.5119961204855, 4247.32042873145, 4249.617534421917, 4251.426057482262, 4853.684510506806, 4968.652194346361, 4997.525235102659, 5006.4743201964, 5021.72380519075, 1254.4919307680404, 1273.961781146567, 1275.4069357748692, 1276.6616846535676, 1279.4498365702837, 836.8284501677142, 837.6272558711315, 854.4104567848165, 855.3371137368465, 872.2803686958284, 4350.630196433275, 4385.51759306476, 4387.5393083726385, 4388.341748737651, 4391.978040109779, 5079.822206222764, 5083.822066227664, 5100.38795344561, 5107.821226257063, 5124.180131178993, 4203.684723645678, 4376.365427013129, 4376.387305777193, 4376.956230437719, 4378.233809083397, 2694.609281654149, 2694.797890158246, 2714.267147870064, 2720.183944816547, 2722.237773423405, 4750.714957102585, 4769.546893045155, 4769.856904292877, 4784.397226929018, 4787.904241915142, 5049.368828896388, 5186.014657215117, 5192.844214673491, 5204.9739751301, 5220.582353411718, 4763.73799441034, 4783.473817880031, 4785.569298763128, 4795.736234507136, 4796.640251981115, 5087.974560127176, 5094.719790411563, 5098.337216161875, 5102.336696229467, 5105.719185444687, 4830.2513110467935, 4973.358791598692, 5010.248462730619, 5020.146575082172, 5032.144535428913, 4772.928406073981, 4775.164346239464, 4780.020095880405, 4786.44955830084, 4791.257355109963, 3633.237020225782, 3639.5450568678916, 3640.9635903641683, 3669.266146770603, 3677.7241706871555, 4886.315915771724, 5061.417936937152, 5067.0, 5072.097963263776, 5087.669301495391, 4942.579880710036, 4951.282064100757, 4954.727489987941, 4962.0, 4962.6774259673, 4947.802087916443, 4947.886725486736, 4951.257311403318, 4956.454789973172, 4972.453030166751, 4739.454962679336, 4865.878353041061, 4870.659053866196, 4880.145974454527, 4881.80472781099, 4864.221724524059, 4952.059108769322, 5026.44709082008, 5082.593392528515, 5114.156164233009, 4934.284528743384, 4954.083494553519, 4968.3292755479, 4969.707875952351, 4971.130052240916], "value": 3754.9346003194173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.8107446154459, 623.1929651101823, 630.501903496238, 637.7289651897945, 651.4853265919924, 12749.872501274984, 13567.796483052762, 14049.15705057696, 14072.929635351835, 14249.928750356234, 13309.600711978655, 13453.730925381511, 13482.0, 13494.190348579092, 13497.190168589892, 627.8053803320985, 773.4237992695449, 790.9841803163933, 791.6398038892319, 792.3304807437706, 654.2214764430313, 660.9669516524178, 661.8907880199786, 663.0385940386435, 741.2365263778318, 821.650798410673, 832.0514613340796, 837.9748607541784, 838.681301105579, 839.1314988986401, 833.2833762963846, 833.4707460762398, 833.829065041665, 833.9332853371716, 834.1991687979547, 487.70250147410053, 570.8858228354304, 605.5458406195354, 605.9333473317931, 606.1513880567242, 13524.729505409936, 13604.659883502893, 14045.227512486912, 14058.718825623533, 14074.648133796634, 12797.552085676956, 12855.935720321431, 13000.479980800852, 13315.93472522196, 13655.522056727967, 9587.90412095877, 9805.754856128582, 11075.612353567667, 11230.213885028052, 11259.21185517014, 3487.7209823214334, 3511.438169892805, 3576.481410195507, 3635.581908080578, 3648.41625339947, 61578.69210653918, 63424.0, 64957.0, 65229.0, 66317.6736465268, 10395.84406233907, 10398.584056637801, 10412.502541872649, 10468.162546996222, 10630.73423164427, 18903.0, 19038.714419283722, 19073.2370705173, 19096.331628393218, 19108.426747197605, 6618.30507796684, 6738.696758645872, 6779.898301525481, 6812.420944219797, 6888.173419189729, 3548.911277218039, 3647.708183345326, 3666.3217304798163, 3690.7601005935066, 3766.3597188478025, 2717.660292463442, 2774.9861250693616, 2795.3011747063233, 2797.8461184634634, 2799.1322689966178, 462.098907131089, 466.8809453589381, 479.7049814364141, 480.9278608208797, 487.76343473415363, 452.73062527795906, 465.4763391184917, 501.2105933155222, 537.4310794402761, 552.9612927095145, 8646.783830404165, 8719.618142238038, 8823.205911467998, 8828.161324674145, 8988.46069235848, 534.2520471340077, 605.5639939243738, 610.1610285856947, 615.9969200153971, 630.0863747566048, 3848.4990853567133, 4021.356582946773, 4083.7549747015273, 4199.139176468817, 4202.159568086395, 93793.0, 94712.0, 95729.5213523928, 96713.51643241738, 97885.0, 48782.75608622005, 59336.40663593309, 74444.0, 86316.56841715751, 86968.56515717508, 72761.2723872765, 73284.63357683178, 78960.70912554329, 79825.0, 81288.18711812925, 7791.961040194763, 7849.136594974662, 7898.605069746604, 8118.878216826634, 8128.593570321342, 42909.785451072545, 43941.78029109834, 44391.77804110959, 44443.77778111089, 44787.55212447834, 60095.699521502116, 64197.0, 64367.67816161077, 64369.0, 65746.34253657403, 9441.52792360393, 9684.85472717924, 9867.16129129032, 9941.552630131517, 10039.397636141855, 11652.126090543074, 11718.472668730099, 11757.882421175678, 11768.293902365886, 11852.0, 10768.19238557127, 10981.670549883516, 10996.340219586851, 11142.832857507306, 11638.941805291259, 9601.32790704672, 10354.326968747007, 10547.525361358605, 12012.519499220283, 12113.394330283274, 11634.243774154653, 11679.76640467203, 11884.46519906589, 12105.189509035888, 12551.93724031374, 9861.211103111877, 9910.801783964136, 9998.200143988319, 10329.896701032894, 10751.892481075089, 9602.421514840862, 10231.232657550863, 10298.691039268833, 10691.625793097515, 10739.785204296026], "value": 6468.106392253005, "unit": "score"}], "name": "dromaeo_css", "value": 6518.072019080147, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 125.0, 191.0, 130.0, 131.0, 145.0, 123.0, 194.0, 129.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 164.0, 163.0, 161.0, 161.0, 162.0, 160.0, 161.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 122.0, 79.0, 77.0, 75.0, 77.0, 100.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 129.0, 85.0, 85.0, 86.0, 113.0, 84.0, 86.0, 133.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 119.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 65.0, 62.0, 64.0, 62.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 81.0, 79.0, 79.0, 85.0, 79.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 130.0, 137.0, 131.0, 133.0, 132.0, 134.0, 174.0, 131.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 166.0, 170.0, 166.0, 165.0, 168.0, 169.0, 166.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 71.0, 69.0, 67.0, 68.0, 66.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1538.0, "alertThreshold": 2.0}]} 17:29:59 INFO - Return code: 0 17:29:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:59 INFO - # TBPL SUCCESS # 17:29:59 INFO - Running post-action listener: _resource_record_post_action 17:29:59 INFO - [mozharness: 2016-07-27 00:29:59.337612Z] Finished run-tests step (success) 17:29:59 INFO - Running post-run listener: _resource_record_post_run 17:29:59 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 535814144; Read time: 0; Write time: 510632 17:29:59 INFO - TinderboxPrint: CPU usage
13.0% 17:29:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:29:59 INFO - TinderboxPrint: I/O write bytes / time
535,814,144 / 510,632 17:29:59 INFO - TinderboxPrint: CPU idle
8,334.2 (87.0%) 17:29:59 INFO - TinderboxPrint: CPU user
1,197.3 (12.5%) 17:29:59 INFO - TinderboxPrint: Swap in / out
0 / 0 17:29:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246349824; Read time: 0; Write time: 267720 17:29:59 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289177600; Read time: 0; Write time: 242892 17:29:59 INFO - Running post-run listener: _upload_blobber_files 17:29:59 INFO - Blob upload gear active. 17:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:05 INFO - (blobuploader) - INFO - Done attempting. 17:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:05 INFO - (blobuploader) - INFO - Done attempting. 17:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:06 INFO - (blobuploader) - INFO - Done attempting. 17:30:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:06 INFO - Return code: 0 17:30:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73778d7af09220fa1a9485726bafc499227e9a826e340248989847089e54ec2577ca6b8f6f4c5a5ee97905311ffe680d3043e2a7fb5008200a5c1cbec6d260db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd76b41db9eb67d4b9f9c26c3a46015f5726e40734200d692428639653c0aad7c5f93a43a437a933d0bdcec31e58c9a63e432d83f18c67affe19a10d88a2ceb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08c152c55342a407fca17be3bce2ab52be0b527107259ae954add14cff0d3e104b6ddc5d92ce8e986f3f1e616ba322d3bda8fcb79d25e30784675097045ee86b"} 17:30:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:06 INFO - Contents: 17:30:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73778d7af09220fa1a9485726bafc499227e9a826e340248989847089e54ec2577ca6b8f6f4c5a5ee97905311ffe680d3043e2a7fb5008200a5c1cbec6d260db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd76b41db9eb67d4b9f9c26c3a46015f5726e40734200d692428639653c0aad7c5f93a43a437a933d0bdcec31e58c9a63e432d83f18c67affe19a10d88a2ceb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08c152c55342a407fca17be3bce2ab52be0b527107259ae954add14cff0d3e104b6ddc5d92ce8e986f3f1e616ba322d3bda8fcb79d25e30784675097045ee86b"} 17:30:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:06 INFO - Copying logs to upload dir... 17:30:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.848689 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-26 17:30:06.304904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 17:30:06.308351) ========= 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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 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/73778d7af09220fa1a9485726bafc499227e9a826e340248989847089e54ec2577ca6b8f6f4c5a5ee97905311ffe680d3043e2a7fb5008200a5c1cbec6d260db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd76b41db9eb67d4b9f9c26c3a46015f5726e40734200d692428639653c0aad7c5f93a43a437a933d0bdcec31e58c9a63e432d83f18c67affe19a10d88a2ceb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08c152c55342a407fca17be3bce2ab52be0b527107259ae954add14cff0d3e104b6ddc5d92ce8e986f3f1e616ba322d3bda8fcb79d25e30784675097045ee86b"} build_url:https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/Dqbqb3DoRYiy0o84ckx4Jw/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/73778d7af09220fa1a9485726bafc499227e9a826e340248989847089e54ec2577ca6b8f6f4c5a5ee97905311ffe680d3043e2a7fb5008200a5c1cbec6d260db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd76b41db9eb67d4b9f9c26c3a46015f5726e40734200d692428639653c0aad7c5f93a43a437a933d0bdcec31e58c9a63e432d83f18c67affe19a10d88a2ceb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08c152c55342a407fca17be3bce2ab52be0b527107259ae954add14cff0d3e104b6ddc5d92ce8e986f3f1e616ba322d3bda8fcb79d25e30784675097045ee86b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 17:30:06.333940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:30:06.334278) ========= 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=523ca41ca1e0623de333ad52000001bf-1469575492.668137-785197411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 17:30:06.419329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 17:30:06.419649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 17:30:06.419975) ========= ========= Total master_lag: 0.19 =========