builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1470277260.42 results: success (0) buildid: 20160803185523 builduid: d76a88128eeb460b943379a66c5d8cda revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.420936) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.421453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.421871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.453264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.453552) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 19:21:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-08-03 19:21:01 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.554193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.554547) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:00.604063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 19:21:00.604512) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03e541a38d87381782c7fccea38aaa32cdd491df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03e541a38d87381782c7fccea38aaa32cdd491df --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=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 19:21:01,365 truncating revision to first 12 chars 2016-08-03 19:21:01,365 Setting DEBUG logging. 2016-08-03 19:21:01,365 attempt 1/10 2016-08-03 19:21:01,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03e541a38d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 19:21:02,369 unpacking tar archive at: fx-team-03e541a38d87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 19:21:02.002640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:02.003228) ========= script_repo_revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:02.003791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:02.004326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 19:21:02.016323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-03 19:21:02.016743) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:02 INFO - MultiFileLogger online at 20160803 19:21:02 in /builds/slave/test 19:21:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:21:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:02 INFO - {'append_to_log': False, 19:21:02 INFO - 'base_work_dir': '/builds/slave/test', 19:21:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:21:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:02 INFO - 'branch': 'Fx-Team-Non-PGO', 19:21:02 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:02 INFO - 'config_files': ('talos/linux_config.py',), 19:21:02 INFO - 'default_actions': ('clobber', 19:21:02 INFO - 'read-buildbot-config', 19:21:02 INFO - 'download-and-extract', 19:21:02 INFO - 'populate-webroot', 19:21:02 INFO - 'create-virtualenv', 19:21:02 INFO - 'install', 19:21:02 INFO - 'run-tests'), 19:21:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:02 INFO - 'download_minidump_stackwalk': True, 19:21:02 INFO - 'download_symbols': 'ondemand', 19:21:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:02 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:02 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:02 INFO - 'installer_path': 'installer.exe', 19:21:02 INFO - 'log_level': 'info', 19:21:02 INFO - 'log_name': 'talos', 19:21:02 INFO - 'log_to_console': True, 19:21:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:02 INFO - 'opt_config_files': (), 19:21:02 INFO - 'pip_index': False, 19:21:02 INFO - 'sps_profile': False, 19:21:02 INFO - 'sps_profile_interval': 0, 19:21:02 INFO - 'suite': 'dromaeojs', 19:21:02 INFO - 'system_bits': '32', 19:21:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:02 INFO - 'title': 'talos-linux64-ix-066', 19:21:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:02 INFO - 'use_talos_json': True, 19:21:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:02 INFO - 'work_dir': 'build'} 19:21:02 INFO - [mozharness: 2016-08-04 02:21:02.871088Z] Running clobber step. 19:21:02 INFO - Running pre-action listener: _resource_record_pre_action 19:21:02 INFO - Running main action method: clobber 19:21:02 INFO - rmtree: /builds/slave/test/build 19:21:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:03 INFO - Running post-action listener: _resource_record_post_action 19:21:03 INFO - [mozharness: 2016-08-04 02:21:03.341915Z] Finished clobber step (success) 19:21:03 INFO - [mozharness: 2016-08-04 02:21:03.342018Z] Running read-buildbot-config step. 19:21:03 INFO - Running pre-action listener: _resource_record_pre_action 19:21:03 INFO - Running main action method: read_buildbot_config 19:21:03 INFO - Using buildbot properties: 19:21:03 INFO - { 19:21:03 INFO - "project": "", 19:21:03 INFO - "product": "firefox", 19:21:03 INFO - "script_repo_revision": "production", 19:21:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:21:03 INFO - "repository": "", 19:21:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:21:03 INFO - "buildid": "20160803185523", 19:21:03 INFO - "pgo_build": "False", 19:21:03 INFO - "basedir": "/builds/slave/test", 19:21:03 INFO - "buildnumber": 2065, 19:21:03 INFO - "slavename": "talos-linux64-ix-066", 19:21:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:21:03 INFO - "platform": "ubuntu64_hw", 19:21:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:21:03 INFO - "branch": "fx-team", 19:21:03 INFO - "repo_path": "integration/fx-team", 19:21:03 INFO - "revision": "03e541a38d87381782c7fccea38aaa32cdd491df", 19:21:03 INFO - "stage_platform": "linux64", 19:21:03 INFO - "builduid": "d76a88128eeb460b943379a66c5d8cda", 19:21:03 INFO - "slavebuilddir": "test" 19:21:03 INFO - } 19:21:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:21:03 INFO - Running post-action listener: _resource_record_post_action 19:21:03 INFO - [mozharness: 2016-08-04 02:21:03.344472Z] Finished read-buildbot-config step (success) 19:21:03 INFO - [mozharness: 2016-08-04 02:21:03.344562Z] Running download-and-extract step. 19:21:03 INFO - Running pre-action listener: _resource_record_pre_action 19:21:03 INFO - Running main action method: download_and_extract 19:21:03 INFO - mkdir: /builds/slave/test/build/tests 19:21:03 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')]} 19:21:03 INFO - https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:21:04 INFO - Downloaded 1361 bytes. 19:21:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:21:04 INFO - Using the following test package requirements: 19:21:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:21:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:21:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'jsshell-linux-x86_64.zip'], 19:21:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:21:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:21:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:21:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:21:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:21:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:21:04 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')]} 19:21:04 INFO - https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:06 INFO - Downloaded 20241522 bytes. 19:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:07 INFO - Return code: 0 19:21:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:21:07 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')]} 19:21:07 INFO - https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:09 INFO - Downloaded 20241522 bytes. 19:21:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:10 INFO - Return code: 0 19:21:10 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')]} 19:21:10 INFO - https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:21:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:21:11 INFO - Downloaded 14413723 bytes. 19:21:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:21:11 INFO - Return code: 0 19:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:11 INFO - https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:21:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:21:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:21:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:21:12 INFO - Downloaded 55631116 bytes. 19:21:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:21:12 INFO - mkdir: /builds/slave/test/properties 19:21:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:21:12 INFO - Writing to file /builds/slave/test/properties/build_url 19:21:12 INFO - Contents: 19:21:12 INFO - build_url:https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:21:13 INFO - Running post-action listener: _resource_record_post_action 19:21:13 INFO - Running post-action listener: set_extra_try_arguments 19:21:13 INFO - [mozharness: 2016-08-04 02:21:13.527147Z] Finished download-and-extract step (success) 19:21:13 INFO - [mozharness: 2016-08-04 02:21:13.527380Z] Running populate-webroot step. 19:21:13 INFO - Running pre-action listener: _resource_record_pre_action 19:21:13 INFO - Running main action method: populate_webroot 19:21:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:21:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:21:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:21:13 INFO - '--tppagecycles', 19:21:13 INFO - '7'], 19:21:13 INFO - 'tests': ['tsvgm']}}, 19:21:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:21:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:21:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:21:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:21:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['damp', 'tps']}, 19:21:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'tests': ['damp', 'tps']}, 19:21:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['dromaeo_dom']}, 19:21:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:21:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['basic_compositor_video']}, 19:21:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:21:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'other-e10s': {'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['a11yr', 19:21:13 INFO - 'ts_paint', 19:21:13 INFO - 'tpaint', 19:21:13 INFO - 'sessionrestore', 19:21:13 INFO - 'sessionrestore_no_auto_restore', 19:21:13 INFO - 'tabpaint']}, 19:21:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['tsvgx', 19:21:13 INFO - 'tsvgr_opacity', 19:21:13 INFO - 'tart', 19:21:13 INFO - 'tscrollx', 19:21:13 INFO - 'cart']}, 19:21:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:21:13 INFO - 'tsvgr_opacity', 19:21:13 INFO - 'tart', 19:21:13 INFO - 'tscrollx', 19:21:13 INFO - 'cart']}, 19:21:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'talos_options': ['--disable-e10s'], 19:21:13 INFO - 'tests': ['tp5o']}, 19:21:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'tests': ['tp5o']}, 19:21:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'talos_options': ['--disable-e10s', 19:21:13 INFO - '--xperf_path', 19:21:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:13 INFO - 'tests': ['tp5n']}, 19:21:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:13 INFO - 'talos_options': ['--xperf_path', 19:21:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:13 INFO - 'tests': ['tp5n']}}, 19:21:13 INFO - 'talos.zip': {'path': '', 19:21:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:21:13 INFO - Running post-action listener: _resource_record_post_action 19:21:13 INFO - [mozharness: 2016-08-04 02:21:13.547758Z] Finished populate-webroot step (success) 19:21:13 INFO - [mozharness: 2016-08-04 02:21:13.547848Z] Running create-virtualenv step. 19:21:13 INFO - Running pre-action listener: _resource_record_pre_action 19:21:13 INFO - Running main action method: create_virtualenv 19:21:13 INFO - Creating virtualenv /builds/slave/test/build/venv 19:21:13 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 19:21:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:21:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:21:13 INFO - Using real prefix '/usr' 19:21:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:21:14 INFO - Installing distribute.............................................................................................................................................................................................done. 19:21:16 INFO - Installing pip.................done. 19:21:16 INFO - Return code: 0 19:21:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:16 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:16 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 19:21:16 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 19:21:16 INFO - Using env: {'DISPLAY': ':0', 19:21:16 INFO - 'HOME': '/home/cltbld', 19:21:16 INFO - 'LANG': 'en_US.UTF-8', 19:21:16 INFO - 'LANGUAGE': 'en_US:en', 19:21:16 INFO - 'LOGNAME': 'cltbld', 19:21:16 INFO - 'MAIL': '/var/mail/cltbld', 19:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:16 INFO - 'MOZ_NO_REMOTE': '1', 19:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:16 INFO - 'NO_EM_RESTART': '1', 19:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:16 INFO - 'PWD': '/builds/slave/test', 19:21:16 INFO - 'SHELL': '/bin/bash', 19:21:16 INFO - 'SHLVL': '1', 19:21:16 INFO - 'TERM': 'linux', 19:21:16 INFO - 'TMOUT': '86400', 19:21:16 INFO - 'USER': 'cltbld', 19:21:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:16 INFO - '_': '/tools/buildbot/bin/python'} 19:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:16 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 19:21:16 INFO - Cleaning up... 19:21:16 INFO - Return code: 0 19:21:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:16 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:16 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 19:21:16 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 19:21:16 INFO - Using env: {'DISPLAY': ':0', 19:21:16 INFO - 'HOME': '/home/cltbld', 19:21:16 INFO - 'LANG': 'en_US.UTF-8', 19:21:16 INFO - 'LANGUAGE': 'en_US:en', 19:21:16 INFO - 'LOGNAME': 'cltbld', 19:21:16 INFO - 'MAIL': '/var/mail/cltbld', 19:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:16 INFO - 'MOZ_NO_REMOTE': '1', 19:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:16 INFO - 'NO_EM_RESTART': '1', 19:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:16 INFO - 'PWD': '/builds/slave/test', 19:21:16 INFO - 'SHELL': '/bin/bash', 19:21:16 INFO - 'SHLVL': '1', 19:21:16 INFO - 'TERM': 'linux', 19:21:16 INFO - 'TMOUT': '86400', 19:21:16 INFO - 'USER': 'cltbld', 19:21:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:16 INFO - '_': '/tools/buildbot/bin/python'} 19:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:16 INFO - Downloading/unpacking psutil>=3.1.1 19:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:21:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:18 INFO - Installing collected packages: psutil 19:21:18 INFO - Running setup.py install for psutil 19:21:18 INFO - building 'psutil._psutil_linux' extension 19:21:18 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 19:21:18 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 19:21:18 INFO - building 'psutil._psutil_posix' extension 19:21:18 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 19:21:18 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 19:21:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:19 INFO - Successfully installed psutil 19:21:19 INFO - Cleaning up... 19:21:19 INFO - Return code: 0 19:21:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:21:19 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')]} 19:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:19 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')]} 19:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:19 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:19 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 19:21:19 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 19:21:19 INFO - Using env: {'DISPLAY': ':0', 19:21:19 INFO - 'HOME': '/home/cltbld', 19:21:19 INFO - 'LANG': 'en_US.UTF-8', 19:21:19 INFO - 'LANGUAGE': 'en_US:en', 19:21:19 INFO - 'LOGNAME': 'cltbld', 19:21:19 INFO - 'MAIL': '/var/mail/cltbld', 19:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:19 INFO - 'MOZ_NO_REMOTE': '1', 19:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:19 INFO - 'NO_EM_RESTART': '1', 19:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:19 INFO - 'PWD': '/builds/slave/test', 19:21:19 INFO - 'SHELL': '/bin/bash', 19:21:19 INFO - 'SHLVL': '1', 19:21:19 INFO - 'TERM': 'linux', 19:21:19 INFO - 'TMOUT': '86400', 19:21:19 INFO - 'USER': 'cltbld', 19:21:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:19 INFO - '_': '/tools/buildbot/bin/python'} 19:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:21:21 INFO - Installing collected packages: mozsystemmonitor 19:21:21 INFO - Running setup.py install for mozsystemmonitor 19:21:21 INFO - Successfully installed mozsystemmonitor 19:21:21 INFO - Cleaning up... 19:21:21 INFO - Return code: 0 19:21:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:21: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')]} 19:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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')]} 19:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:21 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:21 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 19:21:21 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 19:21:21 INFO - Using env: {'DISPLAY': ':0', 19:21:21 INFO - 'HOME': '/home/cltbld', 19:21:21 INFO - 'LANG': 'en_US.UTF-8', 19:21:21 INFO - 'LANGUAGE': 'en_US:en', 19:21:21 INFO - 'LOGNAME': 'cltbld', 19:21:21 INFO - 'MAIL': '/var/mail/cltbld', 19:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:21 INFO - 'MOZ_NO_REMOTE': '1', 19:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:21 INFO - 'NO_EM_RESTART': '1', 19:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:21 INFO - 'PWD': '/builds/slave/test', 19:21:21 INFO - 'SHELL': '/bin/bash', 19:21:21 INFO - 'SHLVL': '1', 19:21:21 INFO - 'TERM': 'linux', 19:21:21 INFO - 'TMOUT': '86400', 19:21:21 INFO - 'USER': 'cltbld', 19:21:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:21 INFO - '_': '/tools/buildbot/bin/python'} 19:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:21 INFO - Downloading/unpacking jsonschema==2.5.1 19:21:21 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 19:21:21 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 19:21:21 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 19:21:21 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 19:21:21 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 19:21:21 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 19:21:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:21:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:23 INFO - Downloading functools32-3.2.3-2.tar.gz 19:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:21:23 INFO - warning: no files found matching '*.txt' 19:21:23 INFO - no previously-included directories found matching 'build' 19:21:23 INFO - no previously-included directories found matching 'dist' 19:21:23 INFO - no previously-included directories found matching '.git*' 19:21:23 INFO - Installing collected packages: jsonschema, functools32 19:21:23 INFO - Running setup.py install for functools32 19:21:23 INFO - warning: no files found matching '*.txt' 19:21:23 INFO - no previously-included directories found matching 'build' 19:21:23 INFO - no previously-included directories found matching 'dist' 19:21:23 INFO - no previously-included directories found matching '.git*' 19:21:23 INFO - Successfully installed jsonschema functools32 19:21:23 INFO - Cleaning up... 19:21:23 INFO - Return code: 0 19:21:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:21:23 INFO - Using env: {'DISPLAY': ':0', 19:21:23 INFO - 'HOME': '/home/cltbld', 19:21:23 INFO - 'LANG': 'en_US.UTF-8', 19:21:23 INFO - 'LANGUAGE': 'en_US:en', 19:21:23 INFO - 'LOGNAME': 'cltbld', 19:21:23 INFO - 'MAIL': '/var/mail/cltbld', 19:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:23 INFO - 'MOZ_NO_REMOTE': '1', 19:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:23 INFO - 'NO_EM_RESTART': '1', 19:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:23 INFO - 'PWD': '/builds/slave/test', 19:21:23 INFO - 'SHELL': '/bin/bash', 19:21:23 INFO - 'SHLVL': '1', 19:21:23 INFO - 'TERM': 'linux', 19:21:23 INFO - 'TMOUT': '86400', 19:21:23 INFO - 'USER': 'cltbld', 19:21:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:23 INFO - '_': '/tools/buildbot/bin/python'} 19:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:21:24 INFO - Cleaning up... 19:21:24 INFO - Return code: 0 19:21:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:24 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:24 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 19:21:24 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 19:21:24 INFO - Using env: {'DISPLAY': ':0', 19:21:24 INFO - 'HOME': '/home/cltbld', 19:21:24 INFO - 'LANG': 'en_US.UTF-8', 19:21:24 INFO - 'LANGUAGE': 'en_US:en', 19:21:24 INFO - 'LOGNAME': 'cltbld', 19:21:24 INFO - 'MAIL': '/var/mail/cltbld', 19:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:24 INFO - 'MOZ_NO_REMOTE': '1', 19:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:24 INFO - 'NO_EM_RESTART': '1', 19:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:24 INFO - 'PWD': '/builds/slave/test', 19:21:24 INFO - 'SHELL': '/bin/bash', 19:21:24 INFO - 'SHLVL': '1', 19:21:24 INFO - 'TERM': 'linux', 19:21:24 INFO - 'TMOUT': '86400', 19:21:24 INFO - 'USER': 'cltbld', 19:21:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:24 INFO - '_': '/tools/buildbot/bin/python'} 19:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:24 INFO - Downloading/unpacking blobuploader==1.2.4 19:21:24 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 19:21:24 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 19:21:24 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 19:21:24 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 19:21:24 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 19:21:24 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 19:21:26 INFO - Downloading blobuploader-1.2.4.tar.gz 19:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:21:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:21:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 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 19:21:26 INFO - Downloading docopt-0.6.1.tar.gz 19:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:21:27 INFO - Installing collected packages: blobuploader, requests, docopt 19:21:27 INFO - Running setup.py install for blobuploader 19:21:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:21:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:21:27 INFO - Running setup.py install for requests 19:21:27 INFO - Running setup.py install for docopt 19:21:27 INFO - Successfully installed blobuploader requests docopt 19:21:27 INFO - Cleaning up... 19:21:27 INFO - Return code: 0 19:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:27 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')]} 19:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:27 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')]} 19:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:27 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:27 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 19:21:27 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 19:21:27 INFO - Using env: {'DISPLAY': ':0', 19:21:27 INFO - 'HOME': '/home/cltbld', 19:21:27 INFO - 'LANG': 'en_US.UTF-8', 19:21:27 INFO - 'LANGUAGE': 'en_US:en', 19:21:27 INFO - 'LOGNAME': 'cltbld', 19:21:27 INFO - 'MAIL': '/var/mail/cltbld', 19:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:27 INFO - 'MOZ_NO_REMOTE': '1', 19:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:27 INFO - 'NO_EM_RESTART': '1', 19:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:27 INFO - 'PWD': '/builds/slave/test', 19:21:27 INFO - 'SHELL': '/bin/bash', 19:21:27 INFO - 'SHLVL': '1', 19:21:27 INFO - 'TERM': 'linux', 19:21:27 INFO - 'TMOUT': '86400', 19:21:27 INFO - 'USER': 'cltbld', 19:21:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:27 INFO - '_': '/tools/buildbot/bin/python'} 19:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:21:27 INFO - Running setup.py (path:/tmp/pip-l0Z02N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:21:27 INFO - Running setup.py (path:/tmp/pip-hTVG8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:21:28 INFO - Running setup.py (path:/tmp/pip-3uMAXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:21:28 INFO - Running setup.py (path:/tmp/pip-5e1xbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:21:28 INFO - Running setup.py (path:/tmp/pip-71XFtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:21:28 INFO - Running setup.py (path:/tmp/pip-3udP__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:21:28 INFO - Running setup.py (path:/tmp/pip-qbeQJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:21:28 INFO - Running setup.py (path:/tmp/pip-zr6xCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:21:28 INFO - Running setup.py (path:/tmp/pip-UMgiej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:21:28 INFO - Running setup.py (path:/tmp/pip-Qy9X13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:21:28 INFO - Running setup.py (path:/tmp/pip-HwzK1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:21:28 INFO - Running setup.py (path:/tmp/pip-JVNmXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:21:28 INFO - Running setup.py (path:/tmp/pip-IXmBTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:21:28 INFO - Running setup.py (path:/tmp/pip-JkjoHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:28 INFO - Running setup.py (path:/tmp/pip-VchrMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:28 INFO - Running setup.py (path:/tmp/pip-9XvFiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:29 INFO - Running setup.py (path:/tmp/pip-f5lZqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:21:29 INFO - Running setup.py install for manifestparser 19:21:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Running setup.py install for mozcrash 19:21:29 INFO - Running setup.py install for mozdebug 19:21:29 INFO - Running setup.py install for mozdevice 19:21:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Running setup.py install for mozfile 19:21:29 INFO - Running setup.py install for mozhttpd 19:21:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Running setup.py install for mozinfo 19:21:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Running setup.py install for mozInstall 19:21:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:21:29 INFO - Running setup.py install for mozleak 19:21:29 INFO - Running setup.py install for mozlog 19:21:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Running setup.py install for moznetwork 19:21:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Running setup.py install for mozprocess 19:21:30 INFO - Running setup.py install for mozprofile 19:21:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Running setup.py install for mozrunner 19:21:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Running setup.py install for mozscreenshot 19:21:30 INFO - Running setup.py install for moztest 19:21:30 INFO - Running setup.py install for mozversion 19:21:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:21:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:21:30 INFO - Cleaning up... 19:21:30 INFO - Return code: 0 19:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:30 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:30 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 19:21:30 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 19:21:30 INFO - Using env: {'DISPLAY': ':0', 19:21:30 INFO - 'HOME': '/home/cltbld', 19:21:30 INFO - 'LANG': 'en_US.UTF-8', 19:21:30 INFO - 'LANGUAGE': 'en_US:en', 19:21:30 INFO - 'LOGNAME': 'cltbld', 19:21:30 INFO - 'MAIL': '/var/mail/cltbld', 19:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:30 INFO - 'MOZ_NO_REMOTE': '1', 19:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:30 INFO - 'NO_EM_RESTART': '1', 19:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:30 INFO - 'PWD': '/builds/slave/test', 19:21:30 INFO - 'SHELL': '/bin/bash', 19:21:30 INFO - 'SHLVL': '1', 19:21:30 INFO - 'TERM': 'linux', 19:21:30 INFO - 'TMOUT': '86400', 19:21:30 INFO - 'USER': 'cltbld', 19:21:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:30 INFO - '_': '/tools/buildbot/bin/python'} 19:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:21:31 INFO - Running setup.py (path:/tmp/pip-eD0nDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:21:31 INFO - Running setup.py (path:/tmp/pip-ERbDf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:21:31 INFO - Running setup.py (path:/tmp/pip-NFtZTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:21:31 INFO - Running setup.py (path:/tmp/pip-omgUkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:21:31 INFO - Running setup.py (path:/tmp/pip-zpC_19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:21:31 INFO - Running setup.py (path:/tmp/pip-W9UmY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:21:31 INFO - Running setup.py (path:/tmp/pip-EoOIn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:21:31 INFO - Running setup.py (path:/tmp/pip-3CTQ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:21:31 INFO - Running setup.py (path:/tmp/pip-TbsvZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:21:31 INFO - Running setup.py (path:/tmp/pip-WmsT85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:21:31 INFO - Running setup.py (path:/tmp/pip-WaDTkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:21:31 INFO - Running setup.py (path:/tmp/pip-Aolyt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:21:31 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)) 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:21:31 INFO - Running setup.py (path:/tmp/pip-BZVDnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:21:32 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)) 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:21:32 INFO - Running setup.py (path:/tmp/pip-tj9Wyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:21:32 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)) 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:32 INFO - Running setup.py (path:/tmp/pip-EBwGhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:32 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)) 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:32 INFO - Running setup.py (path:/tmp/pip-C6eAcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:32 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)) 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:32 INFO - Running setup.py (path:/tmp/pip-wzQMTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:32 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)) 19:21:32 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)) 19:21:32 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)) 19:21:32 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)) 19:21:32 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)) 19:21:32 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)) 19:21:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:34 INFO - Downloading blessings-1.6.tar.gz 19:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:21:34 INFO - Installing collected packages: blessings 19:21:34 INFO - Running setup.py install for blessings 19:21:34 INFO - Successfully installed blessings 19:21:34 INFO - Cleaning up... 19:21:34 INFO - Return code: 0 19:21:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:34 INFO - Reading from file tmpfile_stdout 19:21:34 INFO - Current package versions: 19:21:34 INFO - argparse == 1.2.1 19:21:34 INFO - blessings == 1.6 19:21:34 INFO - blobuploader == 1.2.4 19:21:34 INFO - docopt == 0.6.1 19:21:34 INFO - functools32 == 3.2.3-2 19:21:34 INFO - jsonschema == 2.5.1 19:21:34 INFO - manifestparser == 1.1 19:21:34 INFO - mozInstall == 1.12 19:21:34 INFO - mozcrash == 0.17 19:21:34 INFO - mozdebug == 0.1 19:21:34 INFO - mozdevice == 0.48 19:21:34 INFO - mozfile == 1.2 19:21:34 INFO - mozhttpd == 0.7 19:21:34 INFO - mozinfo == 0.9 19:21:34 INFO - mozleak == 0.1 19:21:34 INFO - mozlog == 3.3 19:21:34 INFO - moznetwork == 0.27 19:21:34 INFO - mozprocess == 0.23 19:21:34 INFO - mozprofile == 0.28 19:21:34 INFO - mozrunner == 6.12 19:21:34 INFO - mozscreenshot == 0.1 19:21:34 INFO - mozsystemmonitor == 0.3 19:21:34 INFO - moztest == 0.7 19:21:34 INFO - mozversion == 1.4 19:21:34 INFO - psutil == 3.1.1 19:21:34 INFO - requests == 1.2.3 19:21:34 INFO - wsgiref == 0.1.2 19:21:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21: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')]} 19:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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')]} 19:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:34 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:34 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 19:21:34 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 19:21:34 INFO - Using env: {'DISPLAY': ':0', 19:21:34 INFO - 'HOME': '/home/cltbld', 19:21:34 INFO - 'LANG': 'en_US.UTF-8', 19:21:34 INFO - 'LANGUAGE': 'en_US:en', 19:21:34 INFO - 'LOGNAME': 'cltbld', 19:21:34 INFO - 'MAIL': '/var/mail/cltbld', 19:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:34 INFO - 'MOZ_NO_REMOTE': '1', 19:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:34 INFO - 'NO_EM_RESTART': '1', 19:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:34 INFO - 'PWD': '/builds/slave/test', 19:21:34 INFO - 'SHELL': '/bin/bash', 19:21:34 INFO - 'SHLVL': '1', 19:21:34 INFO - 'TERM': 'linux', 19:21:34 INFO - 'TMOUT': '86400', 19:21:34 INFO - 'USER': 'cltbld', 19:21:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:34 INFO - '_': '/tools/buildbot/bin/python'} 19:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 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)) 19:21:34 INFO - Cleaning up... 19:21:34 INFO - Return code: 0 19:21:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:21: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')]} 19:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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')]} 19:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:34 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 0x161c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', '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 19:21:34 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 19:21:34 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 19:21:34 INFO - Using env: {'DISPLAY': ':0', 19:21:34 INFO - 'HOME': '/home/cltbld', 19:21:34 INFO - 'LANG': 'en_US.UTF-8', 19:21:34 INFO - 'LANGUAGE': 'en_US:en', 19:21:34 INFO - 'LOGNAME': 'cltbld', 19:21:34 INFO - 'MAIL': '/var/mail/cltbld', 19:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:34 INFO - 'MOZ_NO_REMOTE': '1', 19:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:34 INFO - 'NO_EM_RESTART': '1', 19:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:34 INFO - 'PWD': '/builds/slave/test', 19:21:34 INFO - 'SHELL': '/bin/bash', 19:21:34 INFO - 'SHLVL': '1', 19:21:34 INFO - 'TERM': 'linux', 19:21:34 INFO - 'TMOUT': '86400', 19:21:34 INFO - 'USER': 'cltbld', 19:21:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:34 INFO - '_': '/tools/buildbot/bin/python'} 19:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:21:35 INFO - Cleaning up... 19:21:35 INFO - Return code: 0 19:21:35 INFO - Running post-action listener: _resource_record_post_action 19:21:35 INFO - Running post-action listener: _start_resource_monitoring 19:21:35 INFO - Starting resource monitoring. 19:21:35 INFO - [mozharness: 2016-08-04 02:21:35.142741Z] Finished create-virtualenv step (success) 19:21:35 INFO - [mozharness: 2016-08-04 02:21:35.143207Z] Running install step. 19:21:35 INFO - Running pre-action listener: _resource_record_pre_action 19:21:35 INFO - Running main action method: install 19:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:35 INFO - Reading from file tmpfile_stdout 19:21:35 INFO - Detecting whether we're running mozinstall >=1.0... 19:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:21:35 INFO - Reading from file tmpfile_stdout 19:21:35 INFO - Output received: 19:21:35 INFO - Usage: mozinstall [options] installer 19:21:35 INFO - Options: 19:21:35 INFO - -h, --help show this help message and exit 19:21:35 INFO - -d DEST, --destination=DEST 19:21:35 INFO - Directory to install application into. [default: 19:21:35 INFO - "/builds/slave/test"] 19:21:35 INFO - --app=APP Application being installed. [default: firefox] 19:21:35 INFO - mkdir: /builds/slave/test/build/application 19:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:21:51 INFO - Reading from file tmpfile_stdout 19:21:51 INFO - Output received: 19:21:51 INFO - /builds/slave/test/build/application/firefox/firefox 19:21:51 INFO - Running post-action listener: _resource_record_post_action 19:21:51 INFO - [mozharness: 2016-08-04 02:21:51.444339Z] Finished install step (success) 19:21:51 INFO - [mozharness: 2016-08-04 02:21:51.444616Z] Running run-tests step. 19:21:51 INFO - Running pre-action listener: _resource_record_pre_action 19:21:51 INFO - Running main action method: run_tests 19:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:21:51 INFO - Python 2.7.3 19:21:51 INFO - Return code: 0 19:21:51 INFO - grabbing minidump binary from tooltool 19:21: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')]} 19:21:51 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 0x18db3b0>, '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 0x18dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:21:51 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 19:21:51 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 19:21:51 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 19:21:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:21:51 INFO - Return code: 0 19:21:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:21:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:21:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:21:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:21:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 19:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 19:21:51 INFO - Using env: {'DISPLAY': ':0', 19:21:51 INFO - 'HOME': '/home/cltbld', 19:21:51 INFO - 'LANG': 'en_US.UTF-8', 19:21:51 INFO - 'LANGUAGE': 'en_US:en', 19:21:51 INFO - 'LOGNAME': 'cltbld', 19:21:51 INFO - 'MAIL': '/var/mail/cltbld', 19:21:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:21:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:51 INFO - 'MOZ_NO_REMOTE': '1', 19:21:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:51 INFO - 'NO_EM_RESTART': '1', 19:21:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:51 INFO - 'PWD': '/builds/slave/test', 19:21:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:21:51 INFO - 'SHELL': '/bin/bash', 19:21:51 INFO - 'SHLVL': '1', 19:21:51 INFO - 'TERM': 'linux', 19:21:51 INFO - 'TMOUT': '86400', 19:21:51 INFO - 'USER': 'cltbld', 19:21:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447', 19:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:51 INFO - '_': '/tools/buildbot/bin/python'} 19:21:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 19:21:51 INFO - mozversion application_buildid: 20160803185523 19:21:51 INFO - mozversion application_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 19:21:51 INFO - mozversion application_display_name: Nightly 19:21:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:21:51 INFO - mozversion application_name: Firefox 19:21:51 INFO - mozversion application_remotingname: firefox 19:21:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:21:51 INFO - mozversion application_vendor: Mozilla 19:21:51 INFO - mozversion application_version: 51.0a1 19:21:51 INFO - mozversion platform_buildid: 20160803185523 19:21:51 INFO - mozversion platform_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 19:21:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:21:51 INFO - mozversion platform_version: 51.0a1 19:21:51 INFO - using testdate: 1470277311 19:21:51 INFO - actual date: 1470277311 19:21:51 INFO - starting webserver on 'localhost:47366' 19:21:51 INFO - SUITE-START | Running 2 tests 19:21:51 INFO - TEST-START | dromaeo_css 19:21:51 INFO - operating with platform_type : linux_ 19:21:51 INFO - Initialising browser for dromaeo_css test... 19:21:51 INFO - TEST-INFO | started process 8470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAR7wHZ/profile http://localhost:47366/getInfo.html) 19:21:56 INFO - PROCESS | 8470 | __metrics Screen width/height:1600/1200 19:21:56 INFO - PROCESS | 8470 | colorDepth:24 19:21:56 INFO - PROCESS | 8470 | Browser inner width/height: 1024/697 19:21:56 INFO - PROCESS | 8470 | __metrics 19:21:57 INFO - PROCESS | 8470 | 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" 19:21:57 INFO - PROCESS | 8470 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:21:58 INFO - TEST-INFO | 8470: exit 0 19:21:58 INFO - Browser initialized. 19:21:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:21:58 INFO - TEST-INFO | started process 8550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAR7wHZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:10 INFO - PROCESS | 8550 | RSS: Main: 157786112 19:22:10 INFO - PROCESS | 8550 | 19:23:01 INFO - PROCESS | 8550 | 1470277381285 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] 19:25:14 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47366/tests/dromaeo/cssquery-ext.html) 19:25:16 INFO - PROCESS | 8550 | RSS: Main: 246923264 19:25:16 INFO - PROCESS | 8550 | 19:28:18 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-ext.html (next: http://localhost:47366/tests/dromaeo/cssquery-jquery.html) 19:28:19 INFO - PROCESS | 8550 | RSS: Main: 245878784 19:28:19 INFO - PROCESS | 8550 | 19:31:21 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47366/tests/dromaeo/cssquery-mootools.html) 19:31:22 INFO - PROCESS | 8550 | RSS: Main: 187957248 19:31:22 INFO - PROCESS | 8550 | 19:34:24 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47366/tests/dromaeo/cssquery-prototype.html) 19:34:24 INFO - PROCESS | 8550 | RSS: Main: 197304320 19:34:24 INFO - PROCESS | 8550 | 19:37:28 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47366/tests/dromaeo/cssquery-yui.html) 19:37:28 INFO - PROCESS | 8550 | RSS: Main: 189603840 19:37:28 INFO - PROCESS | 8550 | 19:40:31 INFO - PROCESS | 8550 | Cycle 1(1): loaded http://localhost:47366/tests/dromaeo/cssquery-yui.html (next: http://localhost:47366/tests/dromaeo/cssquery-dojo.html) 19:40:32 INFO - PROCESS | 8550 | RSS: Main: 282898432 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | __start_tp_report 19:40:32 INFO - PROCESS | 8550 | _x_x_mozilla_page_load 19:40:32 INFO - PROCESS | 8550 | _x_x_mozilla_page_load_details 19:40:32 INFO - PROCESS | 8550 | |i|pagename|runs| 19:40:32 INFO - PROCESS | 8550 | |0;dojo.html;2663.374107084836;2706.824056436332;2711.7423844734744;2714.158610830643;2737.0283549339983;4775.8806029849275;4846.588040016599;4866.026794641069;4970.30415741796;4976.576990955768;4894.265860120983;4902.65681402302;4937.753112344378;4951.777170027349;4969.279454479099;4464.910701785971;4498.797554110073;4522.186006518826;4538.228501154812;4681.859544213679;4594.954050459486;4642.744649044301;4644.117617652635;4649.116667833117;4659.673822832403;4356.324769660708;4388.71473354231;4394;4455.353973673799;4524.049949510607;4455.331700244957;4461.330800379937;4468.642508599304;4540.568645978627;4554.316852472156;4449.377087207794;4484.1928452878465;4497.03313787534;4497.9775101124615;4543.227651299287;4766.95233047672;4923.803047878117;4973.204287314049;4985.800567977277;4991.800327986876;5164.845054648366;5208.895822083575;5227.372715274191;5292.073887069786;5302.1781623848365;5293.39126000511;5332.3601167859715;5334.67991920486;5343.09167441532;5358.785648574052;4809.422869255642;4914.213725803854;4932.53140951609;4973.005398920194;4987.10232158215;5423.511883930386;5494.313210848644;5511.200875872976;5517.8344649659775;5526.696031718214;5200.479952004769;5210.270562121306;5219;5256;5265.7103859287345;5132.332796736475;5214.817481388133;5331.067063263913;5371.274877891435;5383.730813459311;5183.792648294101;5184.870378240499;5225;5225.843224703265;5272.261883336336;5193.195054766517;5202.4277329493725;5209;5219.164933610604;5271.051210782096;4327.6321512671775;4461.709988850715;4469.307257375112;4477.1493416250805;4509.458864936163;3806.333891568964;3845.1732877430927;3905.726599138033;3961.920761584752;3984.402339649018;4475.932861007088;4478.552144785561;4485.842995495207;4530.252508336153;4536.5236650151255;5260.631755777135;5298.231756395301;5319.148936170194;5327.280817089721;5331.4935081168005;4300.268954277781;4486.506484286726;4504.1216962692615;4527.320901864681;4574.6340292776495;4787.257975013878;4816.614670826326;4820.638452116105;4821;4869.123557759566;5006.69959802413;5020.723860187579;5021.121303771898;5023.34696489454;5065.620078494054;5072.28987941681;5252.9737351313;5316.3354580677415;5322.361316641873;5403.189521571639;4944.901101978012;4980.800767969386;4982.850514484571;4983.352164218629;5029.346184995927;5241.711705856214;5244.082285600081;5244.475552444725;5248.6588371755715;5250.1074817281915;5103.336566246364;5166.844994650167;5244.7639856207325;5292.338457692788;5302.416734159162;5132.024915266087;5137.409197942285;5138.948610513847;5143.177091665316;5179.274901513716;5129.487051294841;5129.7691603877165;5140.665856719302;5144.588432925282;5196.350456192976;4844.95155048445;5008.173651347633;5040.722760248222;5048.974755126201;5051.318072060225;5194.922076168785;5198.402183748917;5203.843884683465;5209.635325527177;5257.6056795739705;5041.747912604428;5045.2432135180015;5092;5099.158638824552;5141.28022076917 19:40:32 INFO - PROCESS | 8550 | |1;ext.html;564.8587853036738;571.9113537401702;576.1271673414776;579.7738881836082;589.051626880722;29323.853380733093;40367.79816100919;41690.37464438028;41746.7912660437;45362.31956520647;41751.79124104375;42170.156596868044;42192.57807421925;42207.57792422075;42235.36646950291;7726.845463090749;7869.331106855895;7878.290953814156;7878.487898286593;7879.054513458364;7385.446091543129;9826.90173098267;10091;10098.596056157745;10410.375377477338;10151.441670708145;10227.642032528864;10241;10242.385456872611;10244.487775611227;10050.899491005106;10096.141827944633;10122.190224782;10129.13902318304;10133.08802207801;9944.204463642891;10015.148712359458;10021.398716076987;10025.348352357074;10028.348157369748;38529;38814;38839.41740873889;38872.22255554873;38936.61063389358;3095.7368623667016;3151.2909595341093;3270.6075270967635;3361.9495707564406;3373.713234375081;29291.853540732372;29701.405971880657;30176.54735178974;30479.69520304813;31181;3199.2161920329436;3288.161518812711;3332.183615014337;3347.2301370684877;3432.3135372925517;255563;257407;257440;257540;258186;30096.398072038435;57479;58109.70945145247;58228.70885645544;58264;31942.680573194437;33509.83245083759;33542;33559;33659.83170084183;13475.730485390433;13608;13726.588202353945;13732.794008089886;13738.587842364745;9521.952390238004;11220.887791122148;11309.547618095185;11414.258073225214;11457.312561246352;7856.25365590268;7979.122296547375;8054.637541310655;8066.354691624656;8101.432899696964;2997.3405850712807;3075.8000729952482;3146.889858854929;3153.621565412165;3177.856996435166;862.8490014247482;969.9078587534173;971.6307803034802;980.7597138701063;1000.7698229407277;28929.566056509168;29103.56344654832;29438.558421623693;29741;30033;983.7983213441228;1009.6062535611118;1034.9586016559404;1042.166266986408;1088.8747794003632;15432.845671543366;15896.364145434052;15924.203789810463;15992.280347384396;16160.434384796476;400894;404649;405750;406415;406897;50630.49369506331;51220.48779512232;51283;51375.22937155946;51388.74305628448;1089.4661615808197;1154.7055500847398;1171.7129303320742;1185.531714972581;1221.7678641058171;27925.720742792313;29381.41237175287;29968.25079373033;30271.243218919702;30951.226219344695;44178;44531.33203001893;44626;44691.55308446874;44743.776281118386;284986;286207;287223;288006;289317;26009.349766255997;26868.73131268662;27096.458070838868;28022.85988570044;28056.579151313155;42853.571464284956;43142.56857431511;43236.351454728836;44599.33101003423;44960;35346.646533535364;35884.820575896956;36853.815730922244;37668;38595.614043860325;36880.81559592185;37042.8147859259;37132.25735485329;37263.813680931424;37636.811815940746;36815;37061.258774823815;37971.240575188895;38755;38941.41587876241;31948.361032779678;33649.66350336465;33845;34507.4823877637;34584.30831383308;25780.8710956444;26103.216903492164;26177.607335889596;26291.868540657175;26856.865715671298 19:40:32 INFO - PROCESS | 8550 | |2;jquery.html;326.5134948926101;347.65408418623457;357.3442732585705;360.59793330436554;366.8257577650616;12844.293563853997;16155.353785848567;16511.339546418145;16653.750193747102;17472.737908931376;15733.685326293467;16380.83619163808;16939.57651058724;17085.487435376926;17097.31610735569;5049.4950504949575;5092.236164575306;5148.510891465324;5332.120200166968;5350.224217488462;3483.3381657485124;5195.974020129894;5474.589405794582;5510.173473978915;5510.9448905511035;5454.754536045868;5485.835424937259;5528.253685752432;5532.944670553283;5538.224648549206;5304.92042619361;5423.484768946983;5452.972735136339;5520.751566179531;5522.337319521663;5277.6305658603915;5301.231321458367;5307.681539107666;5308.124159513675;5310.097283461821;12137.817932731015;19430;20524.179032838816;20868.47828804277;21010.894945525175;1843.9446816595523;1868.7664041994751;1924.5092501412191;1938.6316599846125;2136.401807493904;8709.129087091304;9000.189982901506;9185.17333439987;11173.664790056311;13514.662133446644;1715.9656806863918;1750.9912450437794;1757.455188891435;1761.6388640328703;1763.7442570827286;70214.64892675554;72668.27331726668;72762.27237727556;72905.27094729038;74149.25850741478;9589.808203835884;9682.370645908135;9744.302666203239;9768.267379946532;9898.366769482955;12547.372631368578;12593.055520835975;12627;12641.304728240035;12656.873431265754;6448.097266382711;6682.599044057372;6829.112215411965;6837;6837;6342.746290148342;6372.776952806629;6410.1987251593555;6568.704408301543;6569.704363303567;4059.188162367538;4098.098418347959;4133.23535145999;4195.853145139906;4246.197509643621;1659.9170041498119;1702.480743373283;1717.1671739206474;1717.7079896417638;1731.8181590933023;835.8955130608674;842.5576572299592;865.7965378136133;871.5642178910545;889.1464194373344;16633.83366166347;16810.353389881137;16876.07181604999;16961.321547138225;17917.19372628235;823.8311146215011;863.4560227056913;864.3560547392108;893.9731808045769;896.2113340260529;9334.299927505464;9413.811723765486;9573.952130239444;10040.544121102399;10181.847272290921;372589;384048;384403;386188;388900;46977.295340569915;47496.5250347499;76694.23305766871;78283;78575.21424785678;935.8689783430461;955.3933252384786;977.2084611464736;977.6969139566758;980.6959842448864;14930.850691492946;15162.696746064796;15514.767278490606;15755.763663544827;15896;36959.260814784095;37642.43536346902;38553.80723096366;38811.223775523766;39058.80470597629;53253;53514.73242633762;53680.46319536755;54263.18605220846;54730.726346368014;6773.119494465688;6853.9314606853295;6923.792286231421;7000.789976300719;7191.460640451883;8847.911520884967;12040.518379264731;12229.266244025386;12242;12292.631221063382;9635.181009614262;9994.650187243411;10147.441890695787;10294.279400441897;10541.789164216827;9606.759831004281;10011.499425028866;10089.243306751876;10141.49292535385;10151.64469243573;9914.124903777823;10001.649942251986;10094.89905100969;10354;10524.263301569123;7017.543859649107;7212.531185472927;7232.819179520554;7280.271972802678;7375.483716139819;8693.652253909773;9438;9448.858267125861;10113.69658910234;10710.571577136827 19:40:32 INFO - PROCESS | 8550 | |3;mootools.html;1242.2732701369698;1374.1136966656504;1411.026391789665;1470.6470447092695;1665.9999999999993;6446.419822215999;7205.279472052799;7441.330280274774;7443.8883416748795;7640.656170472328;7453.552786832794;7457.328840404362;7483.139438964521;7530.698772049125;7533.660985255663;2163.3942496101117;2185.694002839604;2187.57342318248;2192.8574642648177;2195.3633446300555;2104.137303705481;2144.131626691185;2169.240765731989;2172.9022194001227;2176.7823217678183;2096.350131459245;2104.515961328895;2104.9894750526228;2107.1676687708346;2155.1487162570775;2105.6420408530585;2112.5774845031056;2112.7675955645022;2114.862533935297;2117.396541985542;2081.6044951459176;2124.968125478119;2126.0326551419066;2130.478032881954;2132.0192711352797;7293.234210407937;7463.067116610424;7491.9625401872645;7553.735619253354;7554.320111189964;4184.163167366539;4317.41714868495;4352.630026447756;4358.063016451478;4358.215521206182;2723.360010397555;2821.5344468162934;2858.7284208000206;2888.263492809341;2890.768738500915;930.9022552631944;940.9717708468756;942.7030485397078;954.9474778887159;982.2780256511459;9762.414255144715;9956.352837065568;9958.701238962843;9960.651377201762;9966.352187107816;3949.19041596472;3970.1861118470642;4101.241270364992;4111.753294802322;4165.708400411942;7903.56530390834;8018.398620103516;8018.919810801817;8026.197380261927;8030.799230019296;4304.182205380967;4305.182015417061;4310.116426132635;4317.589828966243;4317.654587632982;3509.64903509647;3834.309824231609;3957.2876882161486;3981.5421226559315;3982.661473774762;3357.6810203030673;3404.4893266010295;3488.633693462201;3511.2450823073164;3525.682688557991;1030.953607087683;1050.3172937590627;1064.5582083435288;1065.0521036277719;1065.142560239015;670.9731610735613;833.9708110216113;840;842.5913431985482;856.2379482260793;5038.672486288379;5069.949300506948;5107.387113546398;5151.6908985461;5157.767900444489;389.2642904909723;893.4282059481936;919.4582330152806;919.6643225222746;950.2255661635745;3459.8443070061403;3714.814259287079;3874.6319099685484;3896.201278737852;3977.840886364571;9011.098890110936;9014.639414423349;9248.676296329597;9309.53452327381;9353.532323383804;9130;9166.633334666672;9259.76850578741;9274.21169200612;9280.814383712288;6802.4217941474535;6884.070650462124;6916.723331066701;6958.373746362851;6969;5154.020736060136;5154.458781828004;5197.92203116946;5259.526642602184;5362.51737343641;8272.503649781032;8501.532415717194;8507.957460212907;8520.829583408422;8564.400491965502;8467.322614190727;8780;8823.470591764515;8836.867446988428;8843;5790.420957904176;6256.186695729526;6412.647304398303;6536.607803531803;6566.80299591013;7122.074130363019;7267.345938865527;7319.5242309249725;7320.304571065741;7327.340539351484;6493.155889734304;6559.508036897157;6683.9331606685255;6705.865882682417;6788.151481064867;6531.477481801539;6627.105340778933;6666.266710661726;6718.697658605277;6847.246802851782;6031.939680603138;6176.567640265138;6279.96860015697;6281.183446151971;6281.560290779602;4532.592066714012;4671.906561868812;4698.177818881751;4719.551642593948;4809.495003024772;4524.90950180988;4711.411073615798;4714.81140754366;4717.363155974037;4920.237363208708 19:40:32 INFO - PROCESS | 8550 | |4;prototype.html;277.50465419226674;285.7939495329709;292.67074541141216;293.7811330558734;298.8670041831386;4797.976010119954;4902.852914412569;4955.876103097425;4987.152184128698;4991.326170966923;4719.433667959841;4764.952350476494;4803.375561177051;4807.639427042968;4850.369451971248;3806;3806.1626442182674;3806.6574008339244;3824.7513911595797;3832.9616703832953;3601.45978103284;3812.218495208476;3825.8087095645246;3827.311084004878;3853.65317121459;3575.1598374382;3762.6613604775566;3765.3787125124322;3766.3973764197735;3768.2086761779924;3759.7368184227116;3767.2842159989514;3771.679407250387;3780.7542509736777;3789.3747531657245;3294.5717056782464;3312.8343582821003;3319.186799234179;3324.900252992414;3327.5674162358982;4570.817167313304;4697.459792123916;4718.292256161569;4768.47546769855;4781.928271075936;4318.848840290606;4323.594831679717;4333.739975601443;4336.3278691802825;4337.50118736343;5077.466865979056;5119.87200319995;5121.590272778169;5129.769160387791;5149.069099087842;3374.207061340583;3656.3966945453967;3668.614795446493;3669.412893936984;3676.1728611062563;5269.947300526984;5314.92027619586;5322.2282768998275;5327.813526526553;5338.492843179892;3637.3998290281806;3648.689861361761;3656.4880916671686;3659.2864391443945;3664.2305115925956;3702.148505843671;3707.7775333480076;3724.571674257495;3724.646158614927;3734.8506059757306;4182.205380977604;4231.132617813341;4281.743095414286;4291.785410729451;4335.349697545394;5118.795248190105;5120.513551212629;5124.69251844883;5125.410577783603;5138.2806407103035;1219.7316590350108;1265.936703164838;1278.6446366851167;1290.619267316144;1294.3398866577925;827.3505298340774;846.3398549131687;855.8801767752519;857.6955180910811;863.4646519158036;3963.722539422213;3990.5235063026284;3997.6801855851463;3998.520177578709;4098.770368889381;4618.56123668251;4626.514216007338;4662.7668616569035;4673.556012178838;4692.225782745809;3995.4606128172327;4020.8689394620897;4130.6282434581035;4454.309582014793;4484.484284307281;2791.748742613134;2798.874050667725;2806.971930280712;2808.4383123375405;2812.9578056329174;4962.131626965267;4974.353334066548;4978.77595508203;4979.701217926936;4981.626378021663;5185.585153187736;5314.7608357624;5358.276632654542;5386.5152136307925;5391.7304134793885;4932.753362331798;4940.961308795065;4943.826966056171;4951.950480495221;4958.652894297436;5303.337082864642;5310.495502927216;5314.362276526687;5324.387695414922;5334.78660853577;4987.850364488926;5198.428172901054;5206.2450944612065;5213.165893457029;5223.190405487156;4963.528464795839;4970.304157417892;4978.556218696537;4993.500649934977;4994.825181118644;3747.9250414992093;3748.4189950557707;3750.1749615084636;3772.7924964127237;3778.9433158502093;5096.522008617608;5267.762950667153;5285.68285902847;5327.280817089798;5349.384820745664;5076;5099.923501147411;5118.283440318432;5129.512696293846;5139.280500729826;5153.201253805666;5164.406093299169;5186.740662966761;5190.2214667800135;5190.662606930538;4740.3126546649855;4824.927626085541;4971.37857767779;5035.622328325317;5043.99120175959;4982.227754697883;5157;5158.819441319686;5163;5173.4826517347965;5063.670861393997;5092.421349381703;5099.2860999460845;5103.10695628271;5117.130087884994 19:40:32 INFO - PROCESS | 8550 | |5;yui.html;653.9738410463582;663.8373598468376;679.4055201698513;721.9025431566737;749.4491548711696;12903.483860645574;13484.595462136127;13648.31758412078;13671;13740;12634.241945483254;12670.619881403549;12680.746385072292;12685.936570317135;12690.555830545933;631.0943795653252;760.3954855889554;766.1189631923277;780.7657702689171;785.4423359414794;792.3700657976893;793.7340990768071;796.1322158846856;796.5061661769711;796.9203079692013;833.4999000599653;834.1366685480529;834.2241715204857;834.2908527751393;834.8163404051099;674.689642764329;688.8828899087167;691.2776148924386;694.5173104692241;825.4222044568796;583.5944018906862;599.2539288585739;602.7528713227556;603.1314906534576;603.8279090459198;12288.262704237774;12302;12304;12318.630441086782;12321.938390308082;12496.375181240901;12536.937315313366;12657.114002019862;13330.429316054415;13491.325433728274;11429.542818287258;11697.473613687405;11924.165308428413;11932.821007684892;12423.4409451574;4040.1919616076607;4052.7365721228025;4081.1225586499045;4224.091820258628;4227.640650544708;63597.68201159011;63706.36293637097;63817.680911595606;64095.67952160256;64636.67681661562;10190.88700480939;10284.897151028543;10472.633457828939;10476;10568.630097946689;18058.458246252634;18063.72904406435;18073.909630452028;18081.909590451964;18112.818871811378;6975.093237879043;6980.441564674814;6984.161900571964;7059.082319298561;7347.228541003225;3762.4168253920684;3844.8077596120083;3869.032741814546;3877.0307423144213;3881.262560113626;2627.067391076179;2694.4341688245686;2718.0758542095386;2718.334008167972;2721.0340329182854;469.0782612167108;469.7392946914427;473.11527443680535;474.964377671676;483.68560435717063;485.1558288577849;531.7686806239221;572.6592677356966;577.3158806813939;605.6275390634728;8199.918000820035;8349.248567628822;8763.430377025474;9000.729978100668;9333.20667743236;523.1081006883255;526.8156145349174;553.4769642687702;570.8687001989566;588.4380416702039;3919.647231749156;3970.7419017763755;4051.2910240707756;4185.916281674349;4227.175700738327;93987;97752;100166.48584870221;104454.47772761088;104733;86321.56839215764;87912.5604371974;90401.54799225961;91376;91810.54094729484;75706.6214668923;78562.6071869637;78704.21295786969;78923.60538197387;79252.60373698095;7981.880271796043;8281.54451505173;8447.113053129578;8504.659813607634;8622.310215182895;44440.777796110815;45040.324395134754;45357.77321113373;45386;45432.772836135606;59618;60515.092273616814;64978.67510662416;67478.66260668666;68400;10372.58509659605;10510.579576816841;10565.947170264408;10573.735656608646;10677.039066484054;12101.75796484083;12189.390530473263;12257.26456412618;12271;13070.934645326712;10658.413787241776;11151.83272250933;11178.608748693756;11294.830577541508;11640.94179529097;11211.439428028729;11660.242084264495;11669.12481563903;11711.1802173847;11880.584179553674;10846.945765271123;11100.333979961228;11643.068554515788;11675.182737208313;11676.591319303783;9599.32804703664;9754.9024509754;9958.352707074017;10174.542145603613;10399.168066554808;9628.277879158952;9628.32601717901;9757.658481953382;9771.853422198816;9792.412455252708 19:40:32 INFO - PROCESS | 8550 | __end_tp_report 19:40:32 INFO - PROCESS | 8550 | __start_cc_report 19:40:32 INFO - PROCESS | 8550 | _x_x_mozilla_cycle_collect,1020 19:40:32 INFO - PROCESS | 8550 | __end_cc_report 19:40:32 INFO - PROCESS | 8550 | __startTimestamp1470278432105__endTimestamp 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | ------- Summary: start ------- 19:40:32 INFO - PROCESS | 8550 | Number of tests: 6 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#0] dojo.html Cycles:165 Average:4872.52 Median:5020.72 stddev:527.09 (10.5%) stddev-sans-first:499.40 19:40:32 INFO - PROCESS | 8550 | Values: 2663.4 2706.8 2711.7 2714.2 2737.0 4775.9 4846.6 4866.0 4970.3 4976.6 4894.3 4902.7 4937.8 4951.8 4969.3 4464.9 4498.8 4522.2 4538.2 4681.9 4595.0 4642.7 4644.1 4649.1 4659.7 4356.3 4388.7 4394.0 4455.4 4524.0 4455.3 4461.3 4468.6 4540.6 4554.3 4449.4 4484.2 4497.0 4498.0 4543.2 4767.0 4923.8 4973.2 4985.8 4991.8 5164.8 5208.9 5227.4 5292.1 5302.2 5293.4 5332.4 5334.7 5343.1 5358.8 4809.4 4914.2 4932.5 4973.0 4987.1 5423.5 5494.3 5511.2 5517.8 5526.7 5200.5 5210.3 5219.0 5256.0 5265.7 5132.3 5214.8 5331.1 5371.3 5383.7 5183.8 5184.9 5225.0 5225.8 5272.3 5193.2 5202.4 5209.0 5219.2 5271.1 4327.6 4461.7 4469.3 4477.1 4509.5 3806.3 3845.2 3905.7 3961.9 3984.4 4475.9 4478.6 4485.8 4530.3 4536.5 5260.6 5298.2 5319.1 5327.3 5331.5 4300.3 4486.5 4504.1 4527.3 4574.6 4787.3 4816.6 4820.6 4821.0 4869.1 5006.7 5020.7 5021.1 5023.3 5065.6 5072.3 5253.0 5316.3 5322.4 5403.2 4944.9 4980.8 4982.9 4983.4 5029.3 5241.7 5244.1 5244.5 5248.7 5250.1 5103.3 5166.8 5244.8 5292.3 5302.4 5132.0 5137.4 5138.9 5143.2 5179.3 5129.5 5129.8 5140.7 5144.6 5196.4 4845.0 5008.2 5040.7 5049.0 5051.3 5194.9 5198.4 5203.8 5209.6 5257.6 5041.7 5045.2 5092.0 5099.2 5141.3 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#1] ext.html Cycles:180 Average:47033.53 Median:3339.71 stddev:85034.46 (2546.2%) stddev-sans-first:85201.43 19:40:32 INFO - PROCESS | 8550 | Values: 564.9 571.9 576.1 579.8 589.1 29323.9 40367.8 41690.4 41746.8 45362.3 41751.8 42170.2 42192.6 42207.6 42235.4 7726.8 7869.3 7878.3 7878.5 7879.1 7385.4 9826.9 10091.0 10098.6 10410.4 10151.4 10227.6 10241.0 10242.4 10244.5 10050.9 10096.1 10122.2 10129.1 10133.1 9944.2 10015.1 10021.4 10025.3 10028.3 38529.0 38814.0 38839.4 38872.2 38936.6 3095.7 3151.3 3270.6 3361.9 3373.7 29291.9 29701.4 30176.5 30479.7 31181.0 3199.2 3288.2 3332.2 3347.2 3432.3 255563.0 257407.0 257440.0 257540.0 258186.0 30096.4 57479.0 58109.7 58228.7 58264.0 31942.7 33509.8 33542.0 33559.0 33659.8 13475.7 13608.0 13726.6 13732.8 13738.6 9522.0 11220.9 11309.5 11414.3 11457.3 7856.3 7979.1 8054.6 8066.4 8101.4 2997.3 3075.8 3146.9 3153.6 3177.9 862.8 969.9 971.6 980.8 1000.8 28929.6 29103.6 29438.6 29741.0 30033.0 983.8 1009.6 1035.0 1042.2 1088.9 15432.8 15896.4 15924.2 15992.3 16160.4 400894.0 404649.0 405750.0 406415.0 406897.0 50630.5 51220.5 51283.0 51375.2 51388.7 1089.5 1154.7 1171.7 1185.5 1221.8 27925.7 29381.4 29968.3 30271.2 30951.2 44178.0 44531.3 44626.0 44691.6 44743.8 284986.0 286207.0 287223.0 288006.0 289317.0 26009.3 26868.7 27096.5 28022.9 28056.6 42853.6 43142.6 43236.4 44599.3 44960.0 35346.6 35884.8 36853.8 37668.0 38595.6 36880.8 37042.8 37132.3 37263.8 37636.8 36815.0 37061.3 37971.2 38755.0 38941.4 31948.4 33649.7 33845.0 34507.5 34584.3 25780.9 26103.2 26177.6 26291.9 26856.9 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#2] jquery.html Cycles:180 Average:23823.31 Median:5120.37 stddev:63289.22 (1236.0%) stddev-sans-first:63442.18 19:40:32 INFO - PROCESS | 8550 | Values: 326.5 347.7 357.3 360.6 366.8 12844.3 16155.4 16511.3 16653.8 17472.7 15733.7 16380.8 16939.6 17085.5 17097.3 5049.5 5092.2 5148.5 5332.1 5350.2 3483.3 5196.0 5474.6 5510.2 5510.9 5454.8 5485.8 5528.3 5532.9 5538.2 5304.9 5423.5 5453.0 5520.8 5522.3 5277.6 5301.2 5307.7 5308.1 5310.1 12137.8 19430.0 20524.2 20868.5 21010.9 1843.9 1868.8 1924.5 1938.6 2136.4 8709.1 9000.2 9185.2 11173.7 13514.7 1716.0 1751.0 1757.5 1761.6 1763.7 70214.6 72668.3 72762.3 72905.3 74149.3 9589.8 9682.4 9744.3 9768.3 9898.4 12547.4 12593.1 12627.0 12641.3 12656.9 6448.1 6682.6 6829.1 6837.0 6837.0 6342.7 6372.8 6410.2 6568.7 6569.7 4059.2 4098.1 4133.2 4195.9 4246.2 1659.9 1702.5 1717.2 1717.7 1731.8 835.9 842.6 865.8 871.6 889.1 16633.8 16810.4 16876.1 16961.3 17917.2 823.8 863.5 864.4 894.0 896.2 9334.3 9413.8 9574.0 10040.5 10181.8 372589.0 384048.0 384403.0 386188.0 388900.0 46977.3 47496.5 76694.2 78283.0 78575.2 935.9 955.4 977.2 977.7 980.7 14930.9 15162.7 15514.8 15755.8 15896.0 36959.3 37642.4 38553.8 38811.2 39058.8 53253.0 53514.7 53680.5 54263.2 54730.7 6773.1 6853.9 6923.8 7000.8 7191.5 8847.9 12040.5 12229.3 12242.0 12292.6 9635.2 9994.7 10147.4 10294.3 10541.8 9606.8 10011.5 10089.2 10141.5 10151.6 9914.1 10001.6 10094.9 10354.0 10524.3 7017.5 7212.5 7232.8 7280.3 7375.5 8693.7 9438.0 9448.9 10113.7 10710.6 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#3] mootools.html Cycles:180 Average:4940.93 Median:5576.47 stddev:2708.60 (48.6%) stddev-sans-first:2701.93 19:40:32 INFO - PROCESS | 8550 | Values: 1242.3 1374.1 1411.0 1470.6 1666.0 6446.4 7205.3 7441.3 7443.9 7640.7 7453.6 7457.3 7483.1 7530.7 7533.7 2163.4 2185.7 2187.6 2192.9 2195.4 2104.1 2144.1 2169.2 2172.9 2176.8 2096.4 2104.5 2105.0 2107.2 2155.1 2105.6 2112.6 2112.8 2114.9 2117.4 2081.6 2125.0 2126.0 2130.5 2132.0 7293.2 7463.1 7492.0 7553.7 7554.3 4184.2 4317.4 4352.6 4358.1 4358.2 2723.4 2821.5 2858.7 2888.3 2890.8 930.9 941.0 942.7 954.9 982.3 9762.4 9956.4 9958.7 9960.7 9966.4 3949.2 3970.2 4101.2 4111.8 4165.7 7903.6 8018.4 8018.9 8026.2 8030.8 4304.2 4305.2 4310.1 4317.6 4317.7 3509.6 3834.3 3957.3 3981.5 3982.7 3357.7 3404.5 3488.6 3511.2 3525.7 1031.0 1050.3 1064.6 1065.1 1065.1 671.0 834.0 840.0 842.6 856.2 5038.7 5069.9 5107.4 5151.7 5157.8 389.3 893.4 919.5 919.7 950.2 3459.8 3714.8 3874.6 3896.2 3977.8 9011.1 9014.6 9248.7 9309.5 9353.5 9130.0 9166.6 9259.8 9274.2 9280.8 6802.4 6884.1 6916.7 6958.4 6969.0 5154.0 5154.5 5197.9 5259.5 5362.5 8272.5 8501.5 8508.0 8520.8 8564.4 8467.3 8780.0 8823.5 8836.9 8843.0 5790.4 6256.2 6412.6 6536.6 6566.8 7122.1 7267.3 7319.5 7320.3 7327.3 6493.2 6559.5 6683.9 6705.9 6788.2 6531.5 6627.1 6666.3 6718.7 6847.2 6031.9 6176.6 6280.0 6281.2 6281.6 4532.6 4671.9 4698.2 4719.6 4809.5 4524.9 4711.4 4714.8 4717.4 4920.2 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#4] prototype.html Cycles:180 Average:4201.17 Median:4766.71 stddev:1233.06 (25.9%) stddev-sans-first:1200.83 19:40:32 INFO - PROCESS | 8550 | Values: 277.5 285.8 292.7 293.8 298.9 4798.0 4902.9 4955.9 4987.2 4991.3 4719.4 4765.0 4803.4 4807.6 4850.4 3806.0 3806.2 3806.7 3824.8 3833.0 3601.5 3812.2 3825.8 3827.3 3853.7 3575.2 3762.7 3765.4 3766.4 3768.2 3759.7 3767.3 3771.7 3780.8 3789.4 3294.6 3312.8 3319.2 3324.9 3327.6 4570.8 4697.5 4718.3 4768.5 4781.9 4318.8 4323.6 4333.7 4336.3 4337.5 5077.5 5119.9 5121.6 5129.8 5149.1 3374.2 3656.4 3668.6 3669.4 3676.2 5269.9 5314.9 5322.2 5327.8 5338.5 3637.4 3648.7 3656.5 3659.3 3664.2 3702.1 3707.8 3724.6 3724.6 3734.9 4182.2 4231.1 4281.7 4291.8 4335.3 5118.8 5120.5 5124.7 5125.4 5138.3 1219.7 1265.9 1278.6 1290.6 1294.3 827.4 846.3 855.9 857.7 863.5 3963.7 3990.5 3997.7 3998.5 4098.8 4618.6 4626.5 4662.8 4673.6 4692.2 3995.5 4020.9 4130.6 4454.3 4484.5 2791.7 2798.9 2807.0 2808.4 2813.0 4962.1 4974.4 4978.8 4979.7 4981.6 5185.6 5314.8 5358.3 5386.5 5391.7 4932.8 4941.0 4943.8 4952.0 4958.7 5303.3 5310.5 5314.4 5324.4 5334.8 4987.9 5198.4 5206.2 5213.2 5223.2 4963.5 4970.3 4978.6 4993.5 4994.8 3747.9 3748.4 3750.2 3772.8 3778.9 5096.5 5267.8 5285.7 5327.3 5349.4 5076.0 5099.9 5118.3 5129.5 5139.3 5153.2 5164.4 5186.7 5190.2 5190.7 4740.3 4824.9 4971.4 5035.6 5044.0 4982.2 5157.0 5158.8 5163.0 5173.5 5063.7 5092.4 5099.3 5103.1 5117.1 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - PROCESS | 8550 | [#5] yui.html Cycles:180 Average:18186.70 Median:469.41 stddev:26376.32 (5619.1%) stddev-sans-first:26417.46 19:40:32 INFO - PROCESS | 8550 | Values: 654.0 663.8 679.4 721.9 749.4 12903.5 13484.6 13648.3 13671.0 13740.0 12634.2 12670.6 12680.7 12685.9 12690.6 631.1 760.4 766.1 780.8 785.4 792.4 793.7 796.1 796.5 796.9 833.5 834.1 834.2 834.3 834.8 674.7 688.9 691.3 694.5 825.4 583.6 599.3 602.8 603.1 603.8 12288.3 12302.0 12304.0 12318.6 12321.9 12496.4 12536.9 12657.1 13330.4 13491.3 11429.5 11697.5 11924.2 11932.8 12423.4 4040.2 4052.7 4081.1 4224.1 4227.6 63597.7 63706.4 63817.7 64095.7 64636.7 10190.9 10284.9 10472.6 10476.0 10568.6 18058.5 18063.7 18073.9 18081.9 18112.8 6975.1 6980.4 6984.2 7059.1 7347.2 3762.4 3844.8 3869.0 3877.0 3881.3 2627.1 2694.4 2718.1 2718.3 2721.0 469.1 469.7 473.1 475.0 483.7 485.2 531.8 572.7 577.3 605.6 8199.9 8349.2 8763.4 9000.7 9333.2 523.1 526.8 553.5 570.9 588.4 3919.6 3970.7 4051.3 4185.9 4227.2 93987.0 97752.0 100166.5 104454.5 104733.0 86321.6 87912.6 90401.5 91376.0 91810.5 75706.6 78562.6 78704.2 78923.6 79252.6 7981.9 8281.5 8447.1 8504.7 8622.3 44440.8 45040.3 45357.8 45386.0 45432.8 59618.0 60515.1 64978.7 67478.7 68400.0 10372.6 10510.6 10565.9 10573.7 10677.0 12101.8 12189.4 12257.3 12271.0 13070.9 10658.4 11151.8 11178.6 11294.8 11640.9 11211.4 11660.2 11669.1 11711.2 11880.6 10846.9 11100.3 11643.1 11675.2 11676.6 9599.3 9754.9 9958.4 10174.5 10399.2 9628.3 9628.3 9757.7 9771.9 9792.4 19:40:32 INFO - PROCESS | 8550 | -------- Summary: end -------- 19:40:32 INFO - PROCESS | 8550 | 19:40:32 INFO - TEST-INFO | 8550: exit 0 19:40:32 INFO - TEST-OK | dromaeo_css | took 1121266ms 19:40:32 INFO - TEST-START | kraken 19:40:32 INFO - operating with platform_type : linux_ 19:40:32 INFO - Initialising browser for kraken test... 19:40:32 INFO - TEST-INFO | started process 8735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtMGnt/profile http://localhost:47366/getInfo.html) 19:40:37 INFO - PROCESS | 8735 | __metrics Screen width/height:1600/1200 19:40:37 INFO - PROCESS | 8735 | colorDepth:24 19:40:37 INFO - PROCESS | 8735 | Browser inner width/height: 1024/697 19:40:37 INFO - PROCESS | 8735 | __metrics 19:40:38 INFO - PROCESS | 8735 | 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" 19:40:38 INFO - PROCESS | 8735 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:40:38 INFO - PROCESS | 8735 | console.error: PushService: 19:40:38 INFO - PROCESS | 8735 | stateChangeProcessEnqueue: Error transitioning state 19:40:38 INFO - PROCESS | 8735 | UnknownError 19:40:39 INFO - TEST-INFO | 8735: exit 0 19:40:39 INFO - Browser initialized. 19:40:39 INFO - Running cycle 1/1 for kraken test... 19:40:39 INFO - TEST-INFO | started process 8814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtMGnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:51 INFO - PROCESS | 8814 | RSS: Main: 157974528 19:40:51 INFO - PROCESS | 8814 | 19:40:54 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47366/tests/kraken/driver.html?testName=audio-beat-detection) 19:40:55 INFO - PROCESS | 8814 | RSS: Main: 214310912 19:40:55 INFO - PROCESS | 8814 | 19:40:57 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47366/tests/kraken/driver.html?testName=audio-dft) 19:40:58 INFO - PROCESS | 8814 | RSS: Main: 192028672 19:40:58 INFO - PROCESS | 8814 | 19:41:01 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47366/tests/kraken/driver.html?testName=audio-fft) 19:41:02 INFO - PROCESS | 8814 | RSS: Main: 272474112 19:41:02 INFO - PROCESS | 8814 | 19:41:04 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47366/tests/kraken/driver.html?testName=audio-oscillator) 19:41:05 INFO - PROCESS | 8814 | RSS: Main: 181559296 19:41:05 INFO - PROCESS | 8814 | 19:41:07 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:41:07 INFO - PROCESS | 8814 | RSS: Main: 185106432 19:41:07 INFO - PROCESS | 8814 | 19:41:11 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47366/tests/kraken/driver.html?testName=imaging-darkroom) 19:41:11 INFO - PROCESS | 8814 | RSS: Main: 222281728 19:41:11 INFO - PROCESS | 8814 | 19:41:15 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47366/tests/kraken/driver.html?testName=imaging-desaturate) 19:41:15 INFO - PROCESS | 8814 | RSS: Main: 215531520 19:41:15 INFO - PROCESS | 8814 | 19:41:18 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47366/tests/kraken/driver.html?testName=json-parse-financial) 19:41:19 INFO - PROCESS | 8814 | RSS: Main: 218931200 19:41:19 INFO - PROCESS | 8814 | 19:41:21 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:41:21 INFO - PROCESS | 8814 | RSS: Main: 184451072 19:41:21 INFO - PROCESS | 8814 | 19:41:23 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:41:24 INFO - PROCESS | 8814 | RSS: Main: 189382656 19:41:24 INFO - PROCESS | 8814 | 19:41:26 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:41:27 INFO - PROCESS | 8814 | RSS: Main: 195153920 19:41:27 INFO - PROCESS | 8814 | 19:41:29 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:41:30 INFO - PROCESS | 8814 | RSS: Main: 190861312 19:41:30 INFO - PROCESS | 8814 | 19:41:33 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:41:34 INFO - PROCESS | 8814 | RSS: Main: 193183744 19:41:34 INFO - PROCESS | 8814 | 19:41:35 INFO - PROCESS | 8814 | Cycle 1(1): loaded http://localhost:47366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47366/tests/kraken/driver.html?testName=ai-astar) 19:41:36 INFO - PROCESS | 8814 | RSS: Main: 244428800 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | __start_tp_report 19:41:36 INFO - PROCESS | 8814 | _x_x_mozilla_page_load 19:41:36 INFO - PROCESS | 8814 | _x_x_mozilla_page_load_details 19:41:36 INFO - PROCESS | 8814 | |i|pagename|runs| 19:41:36 INFO - PROCESS | 8814 | |0;ai-astar;107;116;115;116;116;115;115;115;114;114 19:41:36 INFO - PROCESS | 8814 | |1;audio-beat-detection;155;122;123;189;123;125;152;120;157;122 19:41:36 INFO - PROCESS | 8814 | |2;audio-dft;161;162;162;162;161;161;162;162;164;162 19:41:36 INFO - PROCESS | 8814 | |3;audio-fft;75;82;75;137;75;76;75;77;103;77 19:41:36 INFO - PROCESS | 8814 | |4;audio-oscillator;86;85;124;86;87;85;118;85;86;124 19:41:36 INFO - PROCESS | 8814 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;117 19:41:36 INFO - PROCESS | 8814 | |6;imaging-darkroom;147;147;146;147;146;147;146;146;146;146 19:41:36 INFO - PROCESS | 8814 | |7;imaging-desaturate;94;95;95;95;94;94;95;95;95;94 19:41:36 INFO - PROCESS | 8814 | |8;json-parse-financial;65;63;63;63;63;63;63;63;62;63 19:41:36 INFO - PROCESS | 8814 | |9;json-stringify-tinderbox;65;66;66;65;66;64;65;65;65;65 19:41:36 INFO - PROCESS | 8814 | |10;stanford-crypto-aes;80;89;80;78;90;78;79;78;79;84 19:41:36 INFO - PROCESS | 8814 | |11;stanford-crypto-ccm;139;134;129;130;131;128;131;131;190;139 19:41:36 INFO - PROCESS | 8814 | |12;stanford-crypto-pbkdf2;187;166;164;167;172;170;168;168;170;167 19:41:36 INFO - PROCESS | 8814 | |13;stanford-crypto-sha256-iterative;68;71;70;68;67;68;68;67;69;66 19:41:36 INFO - PROCESS | 8814 | __end_tp_report 19:41:36 INFO - PROCESS | 8814 | __start_cc_report 19:41:36 INFO - PROCESS | 8814 | _x_x_mozilla_cycle_collect,1981 19:41:36 INFO - PROCESS | 8814 | __end_cc_report 19:41:36 INFO - PROCESS | 8814 | __startTimestamp1470278496078__endTimestamp 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | ------- Summary: start ------- 19:41:36 INFO - PROCESS | 8814 | Number of tests: 14 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:0.78 19:41:36 INFO - PROCESS | 8814 | Values: 107.0 116.0 115.0 116.0 116.0 115.0 115.0 115.0 114.0 114.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:138.50 stddev:23.32 (16.8%) stddev-sans-first:23.99 19:41:36 INFO - PROCESS | 8814 | Values: 155.0 122.0 123.0 189.0 123.0 125.0 152.0 120.0 157.0 122.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 19:41:36 INFO - PROCESS | 8814 | Values: 161.0 162.0 162.0 162.0 161.0 161.0 162.0 162.0 164.0 162.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.50 stddev:20.13 (26.7%) stddev-sans-first:21.01 19:41:36 INFO - PROCESS | 8814 | Values: 75.0 82.0 75.0 137.0 75.0 76.0 75.0 77.0 103.0 77.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.50 stddev:17.61 (20.6%) stddev-sans-first:18.26 19:41:36 INFO - PROCESS | 8814 | Values: 86.0 85.0 124.0 86.0 87.0 85.0 118.0 85.0 86.0 124.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:41:36 INFO - PROCESS | 8814 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:41:36 INFO - PROCESS | 8814 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:41:36 INFO - PROCESS | 8814 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.33 19:41:36 INFO - PROCESS | 8814 | Values: 65.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 19:41:36 INFO - PROCESS | 8814 | Values: 65.0 66.0 66.0 65.0 66.0 64.0 65.0 65.0 65.0 65.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.00 stddev:4.58 (5.7%) stddev-sans-first:4.82 19:41:36 INFO - PROCESS | 8814 | Values: 80.0 89.0 80.0 78.0 90.0 78.0 79.0 78.0 79.0 84.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:132.50 stddev:18.60 (14.0%) stddev-sans-first:19.73 19:41:36 INFO - PROCESS | 8814 | Values: 139.0 134.0 129.0 130.0 131.0 128.0 131.0 131.0 190.0 139.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:169.00 stddev:6.42 (3.8%) stddev-sans-first:2.40 19:41:36 INFO - PROCESS | 8814 | Values: 187.0 166.0 164.0 167.0 172.0 170.0 168.0 168.0 170.0 167.0 19:41:36 INFO - PROCESS | 8814 | 19:41:36 INFO - PROCESS | 8814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 19:41:36 INFO - PROCESS | 8814 | Values: 68.0 71.0 70.0 68.0 67.0 68.0 68.0 67.0 69.0 66.0 19:41:36 INFO - PROCESS | 8814 | -------- Summary: end -------- 19:41:36 INFO - PROCESS | 8814 | 19:41:37 INFO - TEST-INFO | 8814: exit 0 19:41:37 INFO - TEST-OK | kraken | took 64222ms 19:41:37 INFO - SUITE-END | took 1185s 19:41:37 INFO - Completed test suite (00:19:45) 19:41:37 INFO - javascript benchmark 19:41:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.374107084836, 2706.824056436332, 2711.7423844734744, 2714.158610830643, 2737.0283549339983, 4775.8806029849275, 4846.588040016599, 4866.026794641069, 4970.30415741796, 4976.576990955768, 4894.265860120983, 4902.65681402302, 4937.753112344378, 4951.777170027349, 4969.279454479099, 4464.910701785971, 4498.797554110073, 4522.186006518826, 4538.228501154812, 4681.859544213679, 4594.954050459486, 4642.744649044301, 4644.117617652635, 4649.116667833117, 4659.673822832403, 4356.324769660708, 4388.71473354231, 4394.0, 4455.353973673799, 4524.049949510607, 4455.331700244957, 4461.330800379937, 4468.642508599304, 4540.568645978627, 4554.316852472156, 4449.377087207794, 4484.1928452878465, 4497.03313787534, 4497.9775101124615, 4543.227651299287, 4766.95233047672, 4923.803047878117, 4973.204287314049, 4985.800567977277, 4991.800327986876, 5164.845054648366, 5208.895822083575, 5227.372715274191, 5292.073887069786, 5302.1781623848365, 5293.39126000511, 5332.3601167859715, 5334.67991920486, 5343.09167441532, 5358.785648574052, 4809.422869255642, 4914.213725803854, 4932.53140951609, 4973.005398920194, 4987.10232158215, 5423.511883930386, 5494.313210848644, 5511.200875872976, 5517.8344649659775, 5526.696031718214, 5200.479952004769, 5210.270562121306, 5219.0, 5256.0, 5265.7103859287345, 5132.332796736475, 5214.817481388133, 5331.067063263913, 5371.274877891435, 5383.730813459311, 5183.792648294101, 5184.870378240499, 5225.0, 5225.843224703265, 5272.261883336336, 5193.195054766517, 5202.4277329493725, 5209.0, 5219.164933610604, 5271.051210782096, 4327.6321512671775, 4461.709988850715, 4469.307257375112, 4477.1493416250805, 4509.458864936163, 3806.333891568964, 3845.1732877430927, 3905.726599138033, 3961.920761584752, 3984.402339649018, 4475.932861007088, 4478.552144785561, 4485.842995495207, 4530.252508336153, 4536.5236650151255, 5260.631755777135, 5298.231756395301, 5319.148936170194, 5327.280817089721, 5331.4935081168005, 4300.268954277781, 4486.506484286726, 4504.1216962692615, 4527.320901864681, 4574.6340292776495, 4787.257975013878, 4816.614670826326, 4820.638452116105, 4821.0, 4869.123557759566, 5006.69959802413, 5020.723860187579, 5021.121303771898, 5023.34696489454, 5065.620078494054, 5072.28987941681, 5252.9737351313, 5316.3354580677415, 5322.361316641873, 5403.189521571639, 4944.901101978012, 4980.800767969386, 4982.850514484571, 4983.352164218629, 5029.346184995927, 5241.711705856214, 5244.082285600081, 5244.475552444725, 5248.6588371755715, 5250.1074817281915, 5103.336566246364, 5166.844994650167, 5244.7639856207325, 5292.338457692788, 5302.416734159162, 5132.024915266087, 5137.409197942285, 5138.948610513847, 5143.177091665316, 5179.274901513716, 5129.487051294841, 5129.7691603877165, 5140.665856719302, 5144.588432925282, 5196.350456192976, 4844.95155048445, 5008.173651347633, 5040.722760248222, 5048.974755126201, 5051.318072060225, 5194.922076168785, 5198.402183748917, 5203.843884683465, 5209.635325527177, 5257.6056795739705, 5041.747912604428, 5045.2432135180015, 5092.0, 5099.158638824552, 5141.28022076917], "value": 4837.74121481356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8587853036738, 571.9113537401702, 576.1271673414776, 579.7738881836082, 589.051626880722, 29323.853380733093, 40367.79816100919, 41690.37464438028, 41746.7912660437, 45362.31956520647, 41751.79124104375, 42170.156596868044, 42192.57807421925, 42207.57792422075, 42235.36646950291, 7726.845463090749, 7869.331106855895, 7878.290953814156, 7878.487898286593, 7879.054513458364, 7385.446091543129, 9826.90173098267, 10091.0, 10098.596056157745, 10410.375377477338, 10151.441670708145, 10227.642032528864, 10241.0, 10242.385456872611, 10244.487775611227, 10050.899491005106, 10096.141827944633, 10122.190224782, 10129.13902318304, 10133.08802207801, 9944.204463642891, 10015.148712359458, 10021.398716076987, 10025.348352357074, 10028.348157369748, 38529.0, 38814.0, 38839.41740873889, 38872.22255554873, 38936.61063389358, 3095.7368623667016, 3151.2909595341093, 3270.6075270967635, 3361.9495707564406, 3373.713234375081, 29291.853540732372, 29701.405971880657, 30176.54735178974, 30479.69520304813, 31181.0, 3199.2161920329436, 3288.161518812711, 3332.183615014337, 3347.2301370684877, 3432.3135372925517, 255563.0, 257407.0, 257440.0, 257540.0, 258186.0, 30096.398072038435, 57479.0, 58109.70945145247, 58228.70885645544, 58264.0, 31942.680573194437, 33509.83245083759, 33542.0, 33559.0, 33659.83170084183, 13475.730485390433, 13608.0, 13726.588202353945, 13732.794008089886, 13738.587842364745, 9521.952390238004, 11220.887791122148, 11309.547618095185, 11414.258073225214, 11457.312561246352, 7856.25365590268, 7979.122296547375, 8054.637541310655, 8066.354691624656, 8101.432899696964, 2997.3405850712807, 3075.8000729952482, 3146.889858854929, 3153.621565412165, 3177.856996435166, 862.8490014247482, 969.9078587534173, 971.6307803034802, 980.7597138701063, 1000.7698229407277, 28929.566056509168, 29103.56344654832, 29438.558421623693, 29741.0, 30033.0, 983.7983213441228, 1009.6062535611118, 1034.9586016559404, 1042.166266986408, 1088.8747794003632, 15432.845671543366, 15896.364145434052, 15924.203789810463, 15992.280347384396, 16160.434384796476, 400894.0, 404649.0, 405750.0, 406415.0, 406897.0, 50630.49369506331, 51220.48779512232, 51283.0, 51375.22937155946, 51388.74305628448, 1089.4661615808197, 1154.7055500847398, 1171.7129303320742, 1185.531714972581, 1221.7678641058171, 27925.720742792313, 29381.41237175287, 29968.25079373033, 30271.243218919702, 30951.226219344695, 44178.0, 44531.33203001893, 44626.0, 44691.55308446874, 44743.776281118386, 284986.0, 286207.0, 287223.0, 288006.0, 289317.0, 26009.349766255997, 26868.73131268662, 27096.458070838868, 28022.85988570044, 28056.579151313155, 42853.571464284956, 43142.56857431511, 43236.351454728836, 44599.33101003423, 44960.0, 35346.646533535364, 35884.820575896956, 36853.815730922244, 37668.0, 38595.614043860325, 36880.81559592185, 37042.8147859259, 37132.25735485329, 37263.813680931424, 37636.811815940746, 36815.0, 37061.258774823815, 37971.240575188895, 38755.0, 38941.41587876241, 31948.361032779678, 33649.66350336465, 33845.0, 34507.4823877637, 34584.30831383308, 25780.8710956444, 26103.216903492164, 26177.607335889596, 26291.868540657175, 26856.865715671298], "value": 17296.664068152768, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5134948926101, 347.65408418623457, 357.3442732585705, 360.59793330436554, 366.8257577650616, 12844.293563853997, 16155.353785848567, 16511.339546418145, 16653.750193747102, 17472.737908931376, 15733.685326293467, 16380.83619163808, 16939.57651058724, 17085.487435376926, 17097.31610735569, 5049.4950504949575, 5092.236164575306, 5148.510891465324, 5332.120200166968, 5350.224217488462, 3483.3381657485124, 5195.974020129894, 5474.589405794582, 5510.173473978915, 5510.9448905511035, 5454.754536045868, 5485.835424937259, 5528.253685752432, 5532.944670553283, 5538.224648549206, 5304.92042619361, 5423.484768946983, 5452.972735136339, 5520.751566179531, 5522.337319521663, 5277.6305658603915, 5301.231321458367, 5307.681539107666, 5308.124159513675, 5310.097283461821, 12137.817932731015, 19430.0, 20524.179032838816, 20868.47828804277, 21010.894945525175, 1843.9446816595523, 1868.7664041994751, 1924.5092501412191, 1938.6316599846125, 2136.401807493904, 8709.129087091304, 9000.189982901506, 9185.17333439987, 11173.664790056311, 13514.662133446644, 1715.9656806863918, 1750.9912450437794, 1757.455188891435, 1761.6388640328703, 1763.7442570827286, 70214.64892675554, 72668.27331726668, 72762.27237727556, 72905.27094729038, 74149.25850741478, 9589.808203835884, 9682.370645908135, 9744.302666203239, 9768.267379946532, 9898.366769482955, 12547.372631368578, 12593.055520835975, 12627.0, 12641.304728240035, 12656.873431265754, 6448.097266382711, 6682.599044057372, 6829.112215411965, 6837.0, 6837.0, 6342.746290148342, 6372.776952806629, 6410.1987251593555, 6568.704408301543, 6569.704363303567, 4059.188162367538, 4098.098418347959, 4133.23535145999, 4195.853145139906, 4246.197509643621, 1659.9170041498119, 1702.480743373283, 1717.1671739206474, 1717.7079896417638, 1731.8181590933023, 835.8955130608674, 842.5576572299592, 865.7965378136133, 871.5642178910545, 889.1464194373344, 16633.83366166347, 16810.353389881137, 16876.07181604999, 16961.321547138225, 17917.19372628235, 823.8311146215011, 863.4560227056913, 864.3560547392108, 893.9731808045769, 896.2113340260529, 9334.299927505464, 9413.811723765486, 9573.952130239444, 10040.544121102399, 10181.847272290921, 372589.0, 384048.0, 384403.0, 386188.0, 388900.0, 46977.295340569915, 47496.5250347499, 76694.23305766871, 78283.0, 78575.21424785678, 935.8689783430461, 955.3933252384786, 977.2084611464736, 977.6969139566758, 980.6959842448864, 14930.850691492946, 15162.696746064796, 15514.767278490606, 15755.763663544827, 15896.0, 36959.260814784095, 37642.43536346902, 38553.80723096366, 38811.223775523766, 39058.80470597629, 53253.0, 53514.73242633762, 53680.46319536755, 54263.18605220846, 54730.726346368014, 6773.119494465688, 6853.9314606853295, 6923.792286231421, 7000.789976300719, 7191.460640451883, 8847.911520884967, 12040.518379264731, 12229.266244025386, 12242.0, 12292.631221063382, 9635.181009614262, 9994.650187243411, 10147.441890695787, 10294.279400441897, 10541.789164216827, 9606.759831004281, 10011.499425028866, 10089.243306751876, 10141.49292535385, 10151.64469243573, 9914.124903777823, 10001.649942251986, 10094.89905100969, 10354.0, 10524.263301569123, 7017.543859649107, 7212.531185472927, 7232.819179520554, 7280.271972802678, 7375.483716139819, 8693.652253909773, 9438.0, 9448.858267125861, 10113.69658910234, 10710.571577136827], "value": 8039.762772153329, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.2732701369698, 1374.1136966656504, 1411.026391789665, 1470.6470447092695, 1665.9999999999993, 6446.419822215999, 7205.279472052799, 7441.330280274774, 7443.8883416748795, 7640.656170472328, 7453.552786832794, 7457.328840404362, 7483.139438964521, 7530.698772049125, 7533.660985255663, 2163.3942496101117, 2185.694002839604, 2187.57342318248, 2192.8574642648177, 2195.3633446300555, 2104.137303705481, 2144.131626691185, 2169.240765731989, 2172.9022194001227, 2176.7823217678183, 2096.350131459245, 2104.515961328895, 2104.9894750526228, 2107.1676687708346, 2155.1487162570775, 2105.6420408530585, 2112.5774845031056, 2112.7675955645022, 2114.862533935297, 2117.396541985542, 2081.6044951459176, 2124.968125478119, 2126.0326551419066, 2130.478032881954, 2132.0192711352797, 7293.234210407937, 7463.067116610424, 7491.9625401872645, 7553.735619253354, 7554.320111189964, 4184.163167366539, 4317.41714868495, 4352.630026447756, 4358.063016451478, 4358.215521206182, 2723.360010397555, 2821.5344468162934, 2858.7284208000206, 2888.263492809341, 2890.768738500915, 930.9022552631944, 940.9717708468756, 942.7030485397078, 954.9474778887159, 982.2780256511459, 9762.414255144715, 9956.352837065568, 9958.701238962843, 9960.651377201762, 9966.352187107816, 3949.19041596472, 3970.1861118470642, 4101.241270364992, 4111.753294802322, 4165.708400411942, 7903.56530390834, 8018.398620103516, 8018.919810801817, 8026.197380261927, 8030.799230019296, 4304.182205380967, 4305.182015417061, 4310.116426132635, 4317.589828966243, 4317.654587632982, 3509.64903509647, 3834.309824231609, 3957.2876882161486, 3981.5421226559315, 3982.661473774762, 3357.6810203030673, 3404.4893266010295, 3488.633693462201, 3511.2450823073164, 3525.682688557991, 1030.953607087683, 1050.3172937590627, 1064.5582083435288, 1065.0521036277719, 1065.142560239015, 670.9731610735613, 833.9708110216113, 840.0, 842.5913431985482, 856.2379482260793, 5038.672486288379, 5069.949300506948, 5107.387113546398, 5151.6908985461, 5157.767900444489, 389.2642904909723, 893.4282059481936, 919.4582330152806, 919.6643225222746, 950.2255661635745, 3459.8443070061403, 3714.814259287079, 3874.6319099685484, 3896.201278737852, 3977.840886364571, 9011.098890110936, 9014.639414423349, 9248.676296329597, 9309.53452327381, 9353.532323383804, 9130.0, 9166.633334666672, 9259.76850578741, 9274.21169200612, 9280.814383712288, 6802.4217941474535, 6884.070650462124, 6916.723331066701, 6958.373746362851, 6969.0, 5154.020736060136, 5154.458781828004, 5197.92203116946, 5259.526642602184, 5362.51737343641, 8272.503649781032, 8501.532415717194, 8507.957460212907, 8520.829583408422, 8564.400491965502, 8467.322614190727, 8780.0, 8823.470591764515, 8836.867446988428, 8843.0, 5790.420957904176, 6256.186695729526, 6412.647304398303, 6536.607803531803, 6566.80299591013, 7122.074130363019, 7267.345938865527, 7319.5242309249725, 7320.304571065741, 7327.340539351484, 6493.155889734304, 6559.508036897157, 6683.9331606685255, 6705.865882682417, 6788.151481064867, 6531.477481801539, 6627.105340778933, 6666.266710661726, 6718.697658605277, 6847.246802851782, 6031.939680603138, 6176.567640265138, 6279.96860015697, 6281.183446151971, 6281.560290779602, 4532.592066714012, 4671.906561868812, 4698.177818881751, 4719.551642593948, 4809.495003024772, 4524.90950180988, 4711.411073615798, 4714.81140754366, 4717.363155974037, 4920.237363208708], "value": 4000.6330432409945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.50465419226674, 285.7939495329709, 292.67074541141216, 293.7811330558734, 298.8670041831386, 4797.976010119954, 4902.852914412569, 4955.876103097425, 4987.152184128698, 4991.326170966923, 4719.433667959841, 4764.952350476494, 4803.375561177051, 4807.639427042968, 4850.369451971248, 3806.0, 3806.1626442182674, 3806.6574008339244, 3824.7513911595797, 3832.9616703832953, 3601.45978103284, 3812.218495208476, 3825.8087095645246, 3827.311084004878, 3853.65317121459, 3575.1598374382, 3762.6613604775566, 3765.3787125124322, 3766.3973764197735, 3768.2086761779924, 3759.7368184227116, 3767.2842159989514, 3771.679407250387, 3780.7542509736777, 3789.3747531657245, 3294.5717056782464, 3312.8343582821003, 3319.186799234179, 3324.900252992414, 3327.5674162358982, 4570.817167313304, 4697.459792123916, 4718.292256161569, 4768.47546769855, 4781.928271075936, 4318.848840290606, 4323.594831679717, 4333.739975601443, 4336.3278691802825, 4337.50118736343, 5077.466865979056, 5119.87200319995, 5121.590272778169, 5129.769160387791, 5149.069099087842, 3374.207061340583, 3656.3966945453967, 3668.614795446493, 3669.412893936984, 3676.1728611062563, 5269.947300526984, 5314.92027619586, 5322.2282768998275, 5327.813526526553, 5338.492843179892, 3637.3998290281806, 3648.689861361761, 3656.4880916671686, 3659.2864391443945, 3664.2305115925956, 3702.148505843671, 3707.7775333480076, 3724.571674257495, 3724.646158614927, 3734.8506059757306, 4182.205380977604, 4231.132617813341, 4281.743095414286, 4291.785410729451, 4335.349697545394, 5118.795248190105, 5120.513551212629, 5124.69251844883, 5125.410577783603, 5138.2806407103035, 1219.7316590350108, 1265.936703164838, 1278.6446366851167, 1290.619267316144, 1294.3398866577925, 827.3505298340774, 846.3398549131687, 855.8801767752519, 857.6955180910811, 863.4646519158036, 3963.722539422213, 3990.5235063026284, 3997.6801855851463, 3998.520177578709, 4098.770368889381, 4618.56123668251, 4626.514216007338, 4662.7668616569035, 4673.556012178838, 4692.225782745809, 3995.4606128172327, 4020.8689394620897, 4130.6282434581035, 4454.309582014793, 4484.484284307281, 2791.748742613134, 2798.874050667725, 2806.971930280712, 2808.4383123375405, 2812.9578056329174, 4962.131626965267, 4974.353334066548, 4978.77595508203, 4979.701217926936, 4981.626378021663, 5185.585153187736, 5314.7608357624, 5358.276632654542, 5386.5152136307925, 5391.7304134793885, 4932.753362331798, 4940.961308795065, 4943.826966056171, 4951.950480495221, 4958.652894297436, 5303.337082864642, 5310.495502927216, 5314.362276526687, 5324.387695414922, 5334.78660853577, 4987.850364488926, 5198.428172901054, 5206.2450944612065, 5213.165893457029, 5223.190405487156, 4963.528464795839, 4970.304157417892, 4978.556218696537, 4993.500649934977, 4994.825181118644, 3747.9250414992093, 3748.4189950557707, 3750.1749615084636, 3772.7924964127237, 3778.9433158502093, 5096.522008617608, 5267.762950667153, 5285.68285902847, 5327.280817089798, 5349.384820745664, 5076.0, 5099.923501147411, 5118.283440318432, 5129.512696293846, 5139.280500729826, 5153.201253805666, 5164.406093299169, 5186.740662966761, 5190.2214667800135, 5190.662606930538, 4740.3126546649855, 4824.927626085541, 4971.37857767779, 5035.622328325317, 5043.99120175959, 4982.227754697883, 5157.0, 5158.819441319686, 5163.0, 5173.4826517347965, 5063.670861393997, 5092.421349381703, 5099.2860999460845, 5103.10695628271, 5117.130087884994], "value": 3806.246252360603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9738410463582, 663.8373598468376, 679.4055201698513, 721.9025431566737, 749.4491548711696, 12903.483860645574, 13484.595462136127, 13648.31758412078, 13671.0, 13740.0, 12634.241945483254, 12670.619881403549, 12680.746385072292, 12685.936570317135, 12690.555830545933, 631.0943795653252, 760.3954855889554, 766.1189631923277, 780.7657702689171, 785.4423359414794, 792.3700657976893, 793.7340990768071, 796.1322158846856, 796.5061661769711, 796.9203079692013, 833.4999000599653, 834.1366685480529, 834.2241715204857, 834.2908527751393, 834.8163404051099, 674.689642764329, 688.8828899087167, 691.2776148924386, 694.5173104692241, 825.4222044568796, 583.5944018906862, 599.2539288585739, 602.7528713227556, 603.1314906534576, 603.8279090459198, 12288.262704237774, 12302.0, 12304.0, 12318.630441086782, 12321.938390308082, 12496.375181240901, 12536.937315313366, 12657.114002019862, 13330.429316054415, 13491.325433728274, 11429.542818287258, 11697.473613687405, 11924.165308428413, 11932.821007684892, 12423.4409451574, 4040.1919616076607, 4052.7365721228025, 4081.1225586499045, 4224.091820258628, 4227.640650544708, 63597.68201159011, 63706.36293637097, 63817.680911595606, 64095.67952160256, 64636.67681661562, 10190.88700480939, 10284.897151028543, 10472.633457828939, 10476.0, 10568.630097946689, 18058.458246252634, 18063.72904406435, 18073.909630452028, 18081.909590451964, 18112.818871811378, 6975.093237879043, 6980.441564674814, 6984.161900571964, 7059.082319298561, 7347.228541003225, 3762.4168253920684, 3844.8077596120083, 3869.032741814546, 3877.0307423144213, 3881.262560113626, 2627.067391076179, 2694.4341688245686, 2718.0758542095386, 2718.334008167972, 2721.0340329182854, 469.0782612167108, 469.7392946914427, 473.11527443680535, 474.964377671676, 483.68560435717063, 485.1558288577849, 531.7686806239221, 572.6592677356966, 577.3158806813939, 605.6275390634728, 8199.918000820035, 8349.248567628822, 8763.430377025474, 9000.729978100668, 9333.20667743236, 523.1081006883255, 526.8156145349174, 553.4769642687702, 570.8687001989566, 588.4380416702039, 3919.647231749156, 3970.7419017763755, 4051.2910240707756, 4185.916281674349, 4227.175700738327, 93987.0, 97752.0, 100166.48584870221, 104454.47772761088, 104733.0, 86321.56839215764, 87912.5604371974, 90401.54799225961, 91376.0, 91810.54094729484, 75706.6214668923, 78562.6071869637, 78704.21295786969, 78923.60538197387, 79252.60373698095, 7981.880271796043, 8281.54451505173, 8447.113053129578, 8504.659813607634, 8622.310215182895, 44440.777796110815, 45040.324395134754, 45357.77321113373, 45386.0, 45432.772836135606, 59618.0, 60515.092273616814, 64978.67510662416, 67478.66260668666, 68400.0, 10372.58509659605, 10510.579576816841, 10565.947170264408, 10573.735656608646, 10677.039066484054, 12101.75796484083, 12189.390530473263, 12257.26456412618, 12271.0, 13070.934645326712, 10658.413787241776, 11151.83272250933, 11178.608748693756, 11294.830577541508, 11640.94179529097, 11211.439428028729, 11660.242084264495, 11669.12481563903, 11711.1802173847, 11880.584179553674, 10846.945765271123, 11100.333979961228, 11643.068554515788, 11675.182737208313, 11676.591319303783, 9599.32804703664, 9754.9024509754, 9958.352707074017, 10174.542145603613, 10399.168066554808, 9628.277879158952, 9628.32601717901, 9757.658481953382, 9771.853422198816, 9792.412455252708], "value": 6580.304264904844, "unit": "score"}], "name": "dromaeo_css", "value": 6379.620040354432, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 116.0, 116.0, 115.0, 115.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 123.0, 189.0, 123.0, 125.0, 152.0, 120.0, 157.0, 122.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 164.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 75.0, 137.0, 75.0, 76.0, 75.0, 77.0, 103.0, 77.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 124.0, 86.0, 87.0, 85.0, 118.0, 85.0, 86.0, 124.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 80.0, 78.0, 90.0, 78.0, 79.0, 78.0, 79.0, 84.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 129.0, 130.0, 131.0, 128.0, 131.0, 131.0, 190.0, 139.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 166.0, 164.0, 167.0, 172.0, 170.0, 168.0, 168.0, 170.0, 167.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 70.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1540.7, "alertThreshold": 2.0}]} 19:41:37 INFO - Return code: 0 19:41:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:41:37 INFO - # TBPL SUCCESS # 19:41:37 INFO - Running post-action listener: _resource_record_post_action 19:41:37 INFO - [mozharness: 2016-08-04 02:41:37.383172Z] Finished run-tests step (success) 19:41:37 INFO - Running post-run listener: _resource_record_post_run 19:41:37 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542478336; Read time: 8; Write time: 627920 19:41:37 INFO - TinderboxPrint: CPU usage
13.0% 19:41:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:41:37 INFO - TinderboxPrint: I/O write bytes / time
542,478,336 / 627,920 19:41:37 INFO - TinderboxPrint: CPU idle
8,343.4 (87.0%) 19:41:37 INFO - TinderboxPrint: CPU user
1,203.3 (12.5%) 19:41:37 INFO - TinderboxPrint: Swap in / out
0 / 0 19:41:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243945472; Read time: 0; Write time: 294732 19:41:37 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 294694912; Read time: 0; Write time: 332456 19:41:38 INFO - Running post-run listener: _upload_blobber_files 19:41:38 INFO - Blob upload gear active. 19:41:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:41:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:41:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:47 INFO - (blobuploader) - INFO - Done attempting. 19:41:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:41:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:48 INFO - (blobuploader) - INFO - Done attempting. 19:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:49 INFO - (blobuploader) - INFO - Done attempting. 19:41:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:41:49 INFO - Return code: 0 19:41:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:41:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:41:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b52d082854f762b2e24aebcaf3b7088ffab355dc9660491002ae27a817e575f7b31a203f3e9ae60429fe4adf8cff9a60850e30d8b9129a6cda9b28eb330c447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4fa40cf167360761b71c17f5857017d3bf525486206eb2d16d4b12b1a66aff4909f1ccc67603c950d75e3c59c6c1dfd7fc41c57e084d438b638805ad8952bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bcc2defd3852704334608fba490760a7b13496261619308b1a30fd29303624b101501c25c1f6bac7e8fad1169eb0cf4fbfaa963906fe12df287966b8085c38"} 19:41:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:41:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:41:49 INFO - Contents: 19:41:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b52d082854f762b2e24aebcaf3b7088ffab355dc9660491002ae27a817e575f7b31a203f3e9ae60429fe4adf8cff9a60850e30d8b9129a6cda9b28eb330c447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4fa40cf167360761b71c17f5857017d3bf525486206eb2d16d4b12b1a66aff4909f1ccc67603c950d75e3c59c6c1dfd7fc41c57e084d438b638805ad8952bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bcc2defd3852704334608fba490760a7b13496261619308b1a30fd29303624b101501c25c1f6bac7e8fad1169eb0cf4fbfaa963906fe12df287966b8085c38"} 19:41:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:41:49 INFO - Copying logs to upload dir... 19:41:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:41:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.751541 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-03 19:41:48.767362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 19:41:48.770735) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b52d082854f762b2e24aebcaf3b7088ffab355dc9660491002ae27a817e575f7b31a203f3e9ae60429fe4adf8cff9a60850e30d8b9129a6cda9b28eb330c447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4fa40cf167360761b71c17f5857017d3bf525486206eb2d16d4b12b1a66aff4909f1ccc67603c950d75e3c59c6c1dfd7fc41c57e084d438b638805ad8952bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bcc2defd3852704334608fba490760a7b13496261619308b1a30fd29303624b101501c25c1f6bac7e8fad1169eb0cf4fbfaa963906fe12df287966b8085c38"} build_url:https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/S7I2BUhsSkmPtdvyrRbAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b52d082854f762b2e24aebcaf3b7088ffab355dc9660491002ae27a817e575f7b31a203f3e9ae60429fe4adf8cff9a60850e30d8b9129a6cda9b28eb330c447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4fa40cf167360761b71c17f5857017d3bf525486206eb2d16d4b12b1a66aff4909f1ccc67603c950d75e3c59c6c1dfd7fc41c57e084d438b638805ad8952bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bcc2defd3852704334608fba490760a7b13496261619308b1a30fd29303624b101501c25c1f6bac7e8fad1169eb0cf4fbfaa963906fe12df287966b8085c38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 19:41:48.799929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:41:48.800301) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470276844.563414-1384511447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:41:48.885125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 19:41:48.885915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 19:41:48.886579) ========= ========= Total master_lag: 0.16 =========