builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1469498638.01 results: success (0) buildid: 20160725173012 builduid: 70326252308a4cb58b41a69ac79be04f revision: 5a8b18f503baa996bcba9ea249e1762b7e536211 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.009652) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.010238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.010621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.026192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.026517) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 19:03:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-25 19:03:58 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126301 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.167406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.167818) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014228 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:58.217218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 19:03:58.217651) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a8b18f503baa996bcba9ea249e1762b7e536211 --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 5a8b18f503baa996bcba9ea249e1762b7e536211 --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=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 19:03:58,248 truncating revision to first 12 chars 2016-07-25 19:03:58,248 Setting DEBUG logging. 2016-07-25 19:03:58,248 attempt 1/10 2016-07-25 19:03:58,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a8b18f503ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 19:03:58,986 unpacking tar archive at: fx-team-5a8b18f503ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.168874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 19:03:59.400858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:59.401225) ========= script_repo_revision: 5a8b18f503baa996bcba9ea249e1762b7e536211 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:59.401692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:59.402016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 19:03:59.413013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-25 19:03:59.413440) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:03:59 INFO - MultiFileLogger online at 20160725 19:03:59 in /builds/slave/test 19:03:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:03:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:03:59 INFO - {'append_to_log': False, 19:03:59 INFO - 'base_work_dir': '/builds/slave/test', 19:03:59 INFO - 'blob_upload_branch': 'Fx-Team', 19:03:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:03:59 INFO - 'branch': 'Fx-Team', 19:03:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:03:59 INFO - 'config_files': ('talos/linux_config.py',), 19:03:59 INFO - 'default_actions': ('clobber', 19:03:59 INFO - 'read-buildbot-config', 19:03:59 INFO - 'download-and-extract', 19:03:59 INFO - 'populate-webroot', 19:03:59 INFO - 'create-virtualenv', 19:03:59 INFO - 'install', 19:03:59 INFO - 'run-tests'), 19:03:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:03:59 INFO - 'download_minidump_stackwalk': True, 19:03:59 INFO - 'download_symbols': 'ondemand', 19:03:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:03:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:03:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:03:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:03:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:03:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:03:59 INFO - 'installer_path': 'installer.exe', 19:03:59 INFO - 'log_level': 'info', 19:03:59 INFO - 'log_name': 'talos', 19:03:59 INFO - 'log_to_console': True, 19:03:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:03:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:03:59 INFO - 'opt_config_files': (), 19:03:59 INFO - 'pip_index': False, 19:03:59 INFO - 'sps_profile': False, 19:03:59 INFO - 'sps_profile_interval': 0, 19:03:59 INFO - 'suite': 'dromaeojs', 19:03:59 INFO - 'system_bits': '32', 19:03:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:03:59 INFO - 'title': 'talos-linux64-ix-051', 19:03:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:03:59 INFO - 'use_talos_json': True, 19:03:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:03:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:03:59 INFO - 'work_dir': 'build'} 19:03:59 INFO - [mozharness: 2016-07-26 02:03:59.530242Z] Running clobber step. 19:03:59 INFO - Running pre-action listener: _resource_record_pre_action 19:03:59 INFO - Running main action method: clobber 19:03:59 INFO - rmtree: /builds/slave/test/build 19:03:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:00 INFO - Running post-action listener: _resource_record_post_action 19:04:00 INFO - [mozharness: 2016-07-26 02:04:00.501335Z] Finished clobber step (success) 19:04:00 INFO - [mozharness: 2016-07-26 02:04:00.501954Z] Running read-buildbot-config step. 19:04:00 INFO - Running pre-action listener: _resource_record_pre_action 19:04:00 INFO - Running main action method: read_buildbot_config 19:04:00 INFO - Using buildbot properties: 19:04:00 INFO - { 19:04:00 INFO - "project": "", 19:04:00 INFO - "product": "firefox", 19:04:00 INFO - "script_repo_revision": "production", 19:04:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:04:00 INFO - "repository": "", 19:04:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:04:00 INFO - "buildid": "20160725173012", 19:04:00 INFO - "pgo_build": "True", 19:04:00 INFO - "basedir": "/builds/slave/test", 19:04:00 INFO - "buildnumber": 1358, 19:04:00 INFO - "slavename": "talos-linux64-ix-051", 19:04:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:04:00 INFO - "platform": "ubuntu64_hw", 19:04:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:04:00 INFO - "branch": "fx-team", 19:04:00 INFO - "repo_path": "integration/fx-team", 19:04:00 INFO - "revision": "5a8b18f503baa996bcba9ea249e1762b7e536211", 19:04:00 INFO - "stage_platform": "linux64-pgo", 19:04:00 INFO - "builduid": "70326252308a4cb58b41a69ac79be04f", 19:04:00 INFO - "slavebuilddir": "test" 19:04:00 INFO - } 19:04:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:04:00 INFO - Running post-action listener: _resource_record_post_action 19:04:00 INFO - [mozharness: 2016-07-26 02:04:00.504381Z] Finished read-buildbot-config step (success) 19:04:00 INFO - [mozharness: 2016-07-26 02:04:00.504471Z] Running download-and-extract step. 19:04:00 INFO - Running pre-action listener: _resource_record_pre_action 19:04:00 INFO - Running main action method: download_and_extract 19:04:00 INFO - mkdir: /builds/slave/test/build/tests 19:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:00 INFO - https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:04:12 INFO - Downloaded 1361 bytes. 19:04:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:12 INFO - Using the following test package requirements: 19:04:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:04:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:04:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'jsshell-linux-x86_64.zip'], 19:04:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:04:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:04:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:04:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:04:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:04:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:12 INFO - https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:04:29 INFO - Downloaded 24311792 bytes. 19:04:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:04:30 INFO - Return code: 0 19:04:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:04: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:04:30 INFO - https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:04:31 INFO - Downloaded 24311792 bytes. 19:04:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:04:32 INFO - Return code: 0 19:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:32 INFO - https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:04:33 INFO - Downloaded 14403248 bytes. 19:04:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:04:34 INFO - Return code: 0 19:04: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:04:34 INFO - https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:04:35 INFO - Downloaded 60904131 bytes. 19:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:35 INFO - mkdir: /builds/slave/test/properties 19:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 19:04:35 INFO - Contents: 19:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:36 INFO - Running post-action listener: _resource_record_post_action 19:04:36 INFO - Running post-action listener: set_extra_try_arguments 19:04:36 INFO - [mozharness: 2016-07-26 02:04:36.406011Z] Finished download-and-extract step (success) 19:04:36 INFO - [mozharness: 2016-07-26 02:04:36.406246Z] Running populate-webroot step. 19:04:36 INFO - Running pre-action listener: _resource_record_pre_action 19:04:36 INFO - Running main action method: populate_webroot 19:04:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:36 INFO - '--tppagecycles', 19:04:36 INFO - '7'], 19:04:36 INFO - 'tests': ['tsvgm']}}, 19:04:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:04:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:04:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:04:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['damp', 'tps']}, 19:04:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'tests': ['damp', 'tps']}, 19:04:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['dromaeo_dom']}, 19:04:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['basic_compositor_video']}, 19:04:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:04:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'other-e10s': {'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['a11yr', 19:04:36 INFO - 'ts_paint', 19:04:36 INFO - 'tpaint', 19:04:36 INFO - 'sessionrestore', 19:04:36 INFO - 'sessionrestore_no_auto_restore', 19:04:36 INFO - 'tabpaint']}, 19:04:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['tsvgx', 19:04:36 INFO - 'tsvgr_opacity', 19:04:36 INFO - 'tart', 19:04:36 INFO - 'tscrollx', 19:04:36 INFO - 'cart']}, 19:04:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:04:36 INFO - 'tsvgr_opacity', 19:04:36 INFO - 'tart', 19:04:36 INFO - 'tscrollx', 19:04:36 INFO - 'cart']}, 19:04:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'talos_options': ['--disable-e10s'], 19:04:36 INFO - 'tests': ['tp5o']}, 19:04:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'tests': ['tp5o']}, 19:04:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'talos_options': ['--disable-e10s', 19:04:36 INFO - '--xperf_path', 19:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:36 INFO - 'tests': ['tp5n']}, 19:04:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:36 INFO - 'talos_options': ['--xperf_path', 19:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:36 INFO - 'tests': ['tp5n']}}, 19:04:36 INFO - 'talos.zip': {'path': '', 19:04:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:36 INFO - Running post-action listener: _resource_record_post_action 19:04:36 INFO - [mozharness: 2016-07-26 02:04:36.426588Z] Finished populate-webroot step (success) 19:04:36 INFO - [mozharness: 2016-07-26 02:04:36.426677Z] Running create-virtualenv step. 19:04:36 INFO - Running pre-action listener: _resource_record_pre_action 19:04:36 INFO - Running main action method: create_virtualenv 19:04:36 INFO - Creating virtualenv /builds/slave/test/build/venv 19:04:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:04:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:04:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:36 INFO - Using real prefix '/usr' 19:04:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:04:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:39 INFO - Installing pip.................done. 19:04:39 INFO - Return code: 0 19:04:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:04:39 INFO - Using env: {'DISPLAY': ':0', 19:04:39 INFO - 'HOME': '/home/cltbld', 19:04:39 INFO - 'LANG': 'en_US.UTF-8', 19:04:39 INFO - 'LANGUAGE': 'en_US:en', 19:04:39 INFO - 'LOGNAME': 'cltbld', 19:04:39 INFO - 'MAIL': '/var/mail/cltbld', 19:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:39 INFO - 'MOZ_NO_REMOTE': '1', 19:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:39 INFO - 'NO_EM_RESTART': '1', 19:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:39 INFO - 'PWD': '/builds/slave/test', 19:04:39 INFO - 'SHELL': '/bin/bash', 19:04:39 INFO - 'SHLVL': '1', 19:04:39 INFO - 'TERM': 'linux', 19:04:39 INFO - 'TMOUT': '86400', 19:04:39 INFO - 'USER': 'cltbld', 19:04:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:39 INFO - '_': '/tools/buildbot/bin/python'} 19:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:04:39 INFO - Cleaning up... 19:04:39 INFO - Return code: 0 19:04:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:04:39 INFO - Using env: {'DISPLAY': ':0', 19:04:39 INFO - 'HOME': '/home/cltbld', 19:04:39 INFO - 'LANG': 'en_US.UTF-8', 19:04:39 INFO - 'LANGUAGE': 'en_US:en', 19:04:39 INFO - 'LOGNAME': 'cltbld', 19:04:39 INFO - 'MAIL': '/var/mail/cltbld', 19:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:39 INFO - 'MOZ_NO_REMOTE': '1', 19:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:39 INFO - 'NO_EM_RESTART': '1', 19:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:39 INFO - 'PWD': '/builds/slave/test', 19:04:39 INFO - 'SHELL': '/bin/bash', 19:04:39 INFO - 'SHLVL': '1', 19:04:39 INFO - 'TERM': 'linux', 19:04:39 INFO - 'TMOUT': '86400', 19:04:39 INFO - 'USER': 'cltbld', 19:04:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:39 INFO - '_': '/tools/buildbot/bin/python'} 19:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:39 INFO - Downloading/unpacking psutil>=3.1.1 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:41 INFO - Installing collected packages: psutil 19:04:41 INFO - Running setup.py install for psutil 19:04:41 INFO - building 'psutil._psutil_linux' extension 19:04:41 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:04:41 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:04:41 INFO - building 'psutil._psutil_posix' extension 19:04:41 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:04:41 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:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:42 INFO - Successfully installed psutil 19:04:42 INFO - Cleaning up... 19:04:42 INFO - Return code: 0 19:04:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:04:42 INFO - Using env: {'DISPLAY': ':0', 19:04:42 INFO - 'HOME': '/home/cltbld', 19:04:42 INFO - 'LANG': 'en_US.UTF-8', 19:04:42 INFO - 'LANGUAGE': 'en_US:en', 19:04:42 INFO - 'LOGNAME': 'cltbld', 19:04:42 INFO - 'MAIL': '/var/mail/cltbld', 19:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:42 INFO - 'MOZ_NO_REMOTE': '1', 19:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:42 INFO - 'NO_EM_RESTART': '1', 19:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:42 INFO - 'PWD': '/builds/slave/test', 19:04:42 INFO - 'SHELL': '/bin/bash', 19:04:42 INFO - 'SHLVL': '1', 19:04:42 INFO - 'TERM': 'linux', 19:04:42 INFO - 'TMOUT': '86400', 19:04:42 INFO - 'USER': 'cltbld', 19:04:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:42 INFO - '_': '/tools/buildbot/bin/python'} 19:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:04:44 INFO - Installing collected packages: mozsystemmonitor 19:04:44 INFO - Running setup.py install for mozsystemmonitor 19:04:44 INFO - Successfully installed mozsystemmonitor 19:04:44 INFO - Cleaning up... 19:04:45 INFO - Return code: 0 19:04:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:04:45 INFO - Using env: {'DISPLAY': ':0', 19:04:45 INFO - 'HOME': '/home/cltbld', 19:04:45 INFO - 'LANG': 'en_US.UTF-8', 19:04:45 INFO - 'LANGUAGE': 'en_US:en', 19:04:45 INFO - 'LOGNAME': 'cltbld', 19:04:45 INFO - 'MAIL': '/var/mail/cltbld', 19:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:45 INFO - 'MOZ_NO_REMOTE': '1', 19:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:45 INFO - 'NO_EM_RESTART': '1', 19:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:45 INFO - 'PWD': '/builds/slave/test', 19:04:45 INFO - 'SHELL': '/bin/bash', 19:04:45 INFO - 'SHLVL': '1', 19:04:45 INFO - 'TERM': 'linux', 19:04:45 INFO - 'TMOUT': '86400', 19:04:45 INFO - 'USER': 'cltbld', 19:04:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:45 INFO - '_': '/tools/buildbot/bin/python'} 19:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:45 INFO - Downloading/unpacking jsonschema==2.5.1 19:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:04:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:04:47 INFO - warning: no files found matching '*.txt' 19:04:47 INFO - no previously-included directories found matching 'build' 19:04:47 INFO - no previously-included directories found matching 'dist' 19:04:47 INFO - no previously-included directories found matching '.git*' 19:04:47 INFO - Installing collected packages: jsonschema, functools32 19:04:47 INFO - Running setup.py install for functools32 19:04:48 INFO - warning: no files found matching '*.txt' 19:04:48 INFO - no previously-included directories found matching 'build' 19:04:48 INFO - no previously-included directories found matching 'dist' 19:04:48 INFO - no previously-included directories found matching '.git*' 19:04:48 INFO - Successfully installed jsonschema functools32 19:04:48 INFO - Cleaning up... 19:04:48 INFO - Return code: 0 19:04:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:04:48 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:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:48 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:04:48 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:04:48 INFO - Using env: {'DISPLAY': ':0', 19:04:48 INFO - 'HOME': '/home/cltbld', 19:04:48 INFO - 'LANG': 'en_US.UTF-8', 19:04:48 INFO - 'LANGUAGE': 'en_US:en', 19:04:48 INFO - 'LOGNAME': 'cltbld', 19:04:48 INFO - 'MAIL': '/var/mail/cltbld', 19:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:48 INFO - 'MOZ_NO_REMOTE': '1', 19:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:48 INFO - 'NO_EM_RESTART': '1', 19:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:48 INFO - 'PWD': '/builds/slave/test', 19:04:48 INFO - 'SHELL': '/bin/bash', 19:04:48 INFO - 'SHLVL': '1', 19:04:48 INFO - 'TERM': 'linux', 19:04:48 INFO - 'TMOUT': '86400', 19:04:48 INFO - 'USER': 'cltbld', 19:04:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:48 INFO - '_': '/tools/buildbot/bin/python'} 19:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:04:48 INFO - Cleaning up... 19:04:48 INFO - Return code: 0 19:04:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:04:48 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:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:48 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:04:48 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:04:48 INFO - Using env: {'DISPLAY': ':0', 19:04:48 INFO - 'HOME': '/home/cltbld', 19:04:48 INFO - 'LANG': 'en_US.UTF-8', 19:04:48 INFO - 'LANGUAGE': 'en_US:en', 19:04:48 INFO - 'LOGNAME': 'cltbld', 19:04:48 INFO - 'MAIL': '/var/mail/cltbld', 19:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:48 INFO - 'MOZ_NO_REMOTE': '1', 19:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:48 INFO - 'NO_EM_RESTART': '1', 19:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:48 INFO - 'PWD': '/builds/slave/test', 19:04:48 INFO - 'SHELL': '/bin/bash', 19:04:48 INFO - 'SHLVL': '1', 19:04:48 INFO - 'TERM': 'linux', 19:04:48 INFO - 'TMOUT': '86400', 19:04:48 INFO - 'USER': 'cltbld', 19:04:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:48 INFO - '_': '/tools/buildbot/bin/python'} 19:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - Downloading blobuploader-1.2.4.tar.gz 19:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:04:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:04:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:51 INFO - Downloading docopt-0.6.1.tar.gz 19:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:04:51 INFO - Installing collected packages: blobuploader, requests, docopt 19:04:51 INFO - Running setup.py install for blobuploader 19:04:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:04:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:04:51 INFO - Running setup.py install for requests 19:04:51 INFO - Running setup.py install for docopt 19:04:51 INFO - Successfully installed blobuploader requests docopt 19:04:51 INFO - Cleaning up... 19:04:51 INFO - Return code: 0 19:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04: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:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:04:51 INFO - Using env: {'DISPLAY': ':0', 19:04:51 INFO - 'HOME': '/home/cltbld', 19:04:51 INFO - 'LANG': 'en_US.UTF-8', 19:04:51 INFO - 'LANGUAGE': 'en_US:en', 19:04:51 INFO - 'LOGNAME': 'cltbld', 19:04:51 INFO - 'MAIL': '/var/mail/cltbld', 19:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:51 INFO - 'MOZ_NO_REMOTE': '1', 19:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:51 INFO - 'NO_EM_RESTART': '1', 19:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:51 INFO - 'PWD': '/builds/slave/test', 19:04:51 INFO - 'SHELL': '/bin/bash', 19:04:51 INFO - 'SHLVL': '1', 19:04:51 INFO - 'TERM': 'linux', 19:04:51 INFO - 'TMOUT': '86400', 19:04:51 INFO - 'USER': 'cltbld', 19:04:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:51 INFO - '_': '/tools/buildbot/bin/python'} 19:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:52 INFO - Running setup.py (path:/tmp/pip-yEzY23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:52 INFO - Running setup.py (path:/tmp/pip-FKIpO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:52 INFO - Running setup.py (path:/tmp/pip-QhhQJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:52 INFO - Running setup.py (path:/tmp/pip-IgITet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:52 INFO - Running setup.py (path:/tmp/pip-hEVgzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:52 INFO - Running setup.py (path:/tmp/pip-TbUOvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:52 INFO - Running setup.py (path:/tmp/pip-ymCeIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:52 INFO - Running setup.py (path:/tmp/pip-qrA__k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:52 INFO - Running setup.py (path:/tmp/pip-iIJJcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:52 INFO - Running setup.py (path:/tmp/pip-UuMqUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:52 INFO - Running setup.py (path:/tmp/pip-gWf9IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:52 INFO - Running setup.py (path:/tmp/pip-TdMcgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:52 INFO - Running setup.py (path:/tmp/pip-UiytFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:52 INFO - Running setup.py (path:/tmp/pip-15RIv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:53 INFO - Running setup.py (path:/tmp/pip-znQdvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:53 INFO - Running setup.py (path:/tmp/pip-JC7rSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:53 INFO - Running setup.py (path:/tmp/pip-_uGP3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:04:53 INFO - Running setup.py install for manifestparser 19:04:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:04:53 INFO - Running setup.py install for mozcrash 19:04:53 INFO - Running setup.py install for mozdebug 19:04:53 INFO - Running setup.py install for mozdevice 19:04:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:04:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:04:53 INFO - Running setup.py install for mozfile 19:04:53 INFO - Running setup.py install for mozhttpd 19:04:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:04:53 INFO - Running setup.py install for mozinfo 19:04:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for mozInstall 19:04:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for mozleak 19:04:54 INFO - Running setup.py install for mozlog 19:04:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for moznetwork 19:04:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for mozprocess 19:04:54 INFO - Running setup.py install for mozprofile 19:04:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for mozrunner 19:04:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:04:54 INFO - Running setup.py install for mozscreenshot 19:04:54 INFO - Running setup.py install for moztest 19:04:54 INFO - Running setup.py install for mozversion 19:04:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:04:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:55 INFO - Cleaning up... 19:04:55 INFO - Return code: 0 19:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:55 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:04:55 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:04:55 INFO - Using env: {'DISPLAY': ':0', 19:04:55 INFO - 'HOME': '/home/cltbld', 19:04:55 INFO - 'LANG': 'en_US.UTF-8', 19:04:55 INFO - 'LANGUAGE': 'en_US:en', 19:04:55 INFO - 'LOGNAME': 'cltbld', 19:04:55 INFO - 'MAIL': '/var/mail/cltbld', 19:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:55 INFO - 'MOZ_NO_REMOTE': '1', 19:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:55 INFO - 'NO_EM_RESTART': '1', 19:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:55 INFO - 'PWD': '/builds/slave/test', 19:04:55 INFO - 'SHELL': '/bin/bash', 19:04:55 INFO - 'SHLVL': '1', 19:04:55 INFO - 'TERM': 'linux', 19:04:55 INFO - 'TMOUT': '86400', 19:04:55 INFO - 'USER': 'cltbld', 19:04:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:55 INFO - '_': '/tools/buildbot/bin/python'} 19:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:55 INFO - Running setup.py (path:/tmp/pip-_MRM0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:55 INFO - Running setup.py (path:/tmp/pip-R1gdbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:55 INFO - Running setup.py (path:/tmp/pip-ns2Yq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 INFO - Running setup.py (path:/tmp/pip-p05wkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:55 INFO - Running setup.py (path:/tmp/pip-tuYaTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 INFO - Running setup.py (path:/tmp/pip-7XYVcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 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:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Running setup.py (path:/tmp/pip-KO4Oig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Running setup.py (path:/tmp/pip-4MpaH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Running setup.py (path:/tmp/pip-MSE5kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:55 INFO - Running setup.py (path:/tmp/pip-oGJqqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:56 INFO - Running setup.py (path:/tmp/pip-IiHQQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:56 INFO - Running setup.py (path:/tmp/pip-1x85QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:56 INFO - Running setup.py (path:/tmp/pip-0LiR2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 INFO - Running setup.py (path:/tmp/pip-_R9qHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 INFO - Running setup.py (path:/tmp/pip-kURSU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:56 INFO - Running setup.py (path:/tmp/pip-taU9cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:56 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:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:56 INFO - Running setup.py (path:/tmp/pip-wfmBEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:56 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:04:56 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:04:56 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:04:56 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:04:56 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:04:56 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:04:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:04:56 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:04:56 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:04:56 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:04:56 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:04:56 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:04:56 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:04:58 INFO - Downloading blessings-1.6.tar.gz 19:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:04:58 INFO - Installing collected packages: blessings 19:04:58 INFO - Running setup.py install for blessings 19:04:58 INFO - Successfully installed blessings 19:04:58 INFO - Cleaning up... 19:04:58 INFO - Return code: 0 19:04:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:58 INFO - Reading from file tmpfile_stdout 19:04:58 INFO - Current package versions: 19:04:58 INFO - argparse == 1.2.1 19:04:58 INFO - blessings == 1.6 19:04:58 INFO - blobuploader == 1.2.4 19:04:58 INFO - docopt == 0.6.1 19:04:58 INFO - functools32 == 3.2.3-2 19:04:58 INFO - jsonschema == 2.5.1 19:04:58 INFO - manifestparser == 1.1 19:04:58 INFO - mozInstall == 1.12 19:04:58 INFO - mozcrash == 0.17 19:04:58 INFO - mozdebug == 0.1 19:04:58 INFO - mozdevice == 0.48 19:04:58 INFO - mozfile == 1.2 19:04:58 INFO - mozhttpd == 0.7 19:04:58 INFO - mozinfo == 0.9 19:04:58 INFO - mozleak == 0.1 19:04:58 INFO - mozlog == 3.3 19:04:58 INFO - moznetwork == 0.27 19:04:58 INFO - mozprocess == 0.23 19:04:58 INFO - mozprofile == 0.28 19:04:58 INFO - mozrunner == 6.12 19:04:58 INFO - mozscreenshot == 0.1 19:04:58 INFO - mozsystemmonitor == 0.3 19:04:58 INFO - moztest == 0.7 19:04:58 INFO - mozversion == 1.4 19:04:58 INFO - psutil == 3.1.1 19:04:58 INFO - requests == 1.2.3 19:04:58 INFO - wsgiref == 0.1.2 19:04:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:04:58 INFO - Using env: {'DISPLAY': ':0', 19:04:58 INFO - 'HOME': '/home/cltbld', 19:04:58 INFO - 'LANG': 'en_US.UTF-8', 19:04:58 INFO - 'LANGUAGE': 'en_US:en', 19:04:58 INFO - 'LOGNAME': 'cltbld', 19:04:58 INFO - 'MAIL': '/var/mail/cltbld', 19:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:58 INFO - 'MOZ_NO_REMOTE': '1', 19:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:58 INFO - 'NO_EM_RESTART': '1', 19:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:58 INFO - 'PWD': '/builds/slave/test', 19:04:58 INFO - 'SHELL': '/bin/bash', 19:04:58 INFO - 'SHLVL': '1', 19:04:58 INFO - 'TERM': 'linux', 19:04:58 INFO - 'TMOUT': '86400', 19:04:58 INFO - 'USER': 'cltbld', 19:04:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:58 INFO - '_': '/tools/buildbot/bin/python'} 19:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 INFO - Cleaning up... 19:04:59 INFO - Return code: 0 19:04:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:04:59 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:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 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:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', '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:04:59 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:04:59 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:04:59 INFO - Using env: {'DISPLAY': ':0', 19:04:59 INFO - 'HOME': '/home/cltbld', 19:04:59 INFO - 'LANG': 'en_US.UTF-8', 19:04:59 INFO - 'LANGUAGE': 'en_US:en', 19:04:59 INFO - 'LOGNAME': 'cltbld', 19:04:59 INFO - 'MAIL': '/var/mail/cltbld', 19:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:59 INFO - 'MOZ_NO_REMOTE': '1', 19:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:59 INFO - 'NO_EM_RESTART': '1', 19:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:59 INFO - 'PWD': '/builds/slave/test', 19:04:59 INFO - 'SHELL': '/bin/bash', 19:04:59 INFO - 'SHLVL': '1', 19:04:59 INFO - 'TERM': 'linux', 19:04:59 INFO - 'TMOUT': '86400', 19:04:59 INFO - 'USER': 'cltbld', 19:04:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:59 INFO - '_': '/tools/buildbot/bin/python'} 19:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:04:59 INFO - Cleaning up... 19:04:59 INFO - Return code: 0 19:04:59 INFO - Running post-action listener: _resource_record_post_action 19:04:59 INFO - Running post-action listener: _start_resource_monitoring 19:04:59 INFO - Starting resource monitoring. 19:04:59 INFO - [mozharness: 2016-07-26 02:04:59.417177Z] Finished create-virtualenv step (success) 19:04:59 INFO - [mozharness: 2016-07-26 02:04:59.417641Z] Running install step. 19:04:59 INFO - Running pre-action listener: _resource_record_pre_action 19:04:59 INFO - Running main action method: install 19:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:59 INFO - Reading from file tmpfile_stdout 19:04:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:04:59 INFO - Reading from file tmpfile_stdout 19:04:59 INFO - Output received: 19:04:59 INFO - Usage: mozinstall [options] installer 19:04:59 INFO - Options: 19:04:59 INFO - -h, --help show this help message and exit 19:04:59 INFO - -d DEST, --destination=DEST 19:04:59 INFO - Directory to install application into. [default: 19:04:59 INFO - "/builds/slave/test"] 19:04:59 INFO - --app=APP Application being installed. [default: firefox] 19:04:59 INFO - mkdir: /builds/slave/test/build/application 19:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:05:16 INFO - Reading from file tmpfile_stdout 19:05:16 INFO - Output received: 19:05:16 INFO - /builds/slave/test/build/application/firefox/firefox 19:05:16 INFO - Running post-action listener: _resource_record_post_action 19:05:16 INFO - [mozharness: 2016-07-26 02:05:16.923746Z] Finished install step (success) 19:05:16 INFO - [mozharness: 2016-07-26 02:05:16.924086Z] Running run-tests step. 19:05:16 INFO - Running pre-action listener: _resource_record_pre_action 19:05:16 INFO - Running main action method: run_tests 19:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:16 INFO - Python 2.7.3 19:05:16 INFO - Return code: 0 19:05:16 INFO - grabbing minidump binary from tooltool 19:05: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:05:16 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 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:16 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:05:16 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:05:16 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:05:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:17 INFO - Return code: 0 19:05:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:05:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:05:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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:05:17 INFO - Using env: {'DISPLAY': ':0', 19:05:17 INFO - 'HOME': '/home/cltbld', 19:05:17 INFO - 'LANG': 'en_US.UTF-8', 19:05:17 INFO - 'LANGUAGE': 'en_US:en', 19:05:17 INFO - 'LOGNAME': 'cltbld', 19:05:17 INFO - 'MAIL': '/var/mail/cltbld', 19:05:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:17 INFO - 'MOZ_NO_REMOTE': '1', 19:05:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:17 INFO - 'NO_EM_RESTART': '1', 19:05:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:17 INFO - 'PWD': '/builds/slave/test', 19:05:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:17 INFO - 'SHELL': '/bin/bash', 19:05:17 INFO - 'SHLVL': '1', 19:05:17 INFO - 'TERM': 'linux', 19:05:17 INFO - 'TMOUT': '86400', 19:05:17 INFO - 'USER': 'cltbld', 19:05:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345', 19:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:17 INFO - '_': '/tools/buildbot/bin/python'} 19:05:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:05:17 INFO - mozversion application_buildid: 20160725173012 19:05:17 INFO - mozversion application_changeset: 5a8b18f503baa996bcba9ea249e1762b7e536211 19:05:17 INFO - mozversion application_display_name: Nightly 19:05:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:17 INFO - mozversion application_name: Firefox 19:05:17 INFO - mozversion application_remotingname: firefox 19:05:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:05:17 INFO - mozversion application_vendor: Mozilla 19:05:17 INFO - mozversion application_version: 50.0a1 19:05:17 INFO - mozversion platform_buildid: 20160725173012 19:05:17 INFO - mozversion platform_changeset: 5a8b18f503baa996bcba9ea249e1762b7e536211 19:05:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:05:17 INFO - mozversion platform_version: 50.0a1 19:05:17 INFO - using testdate: 1469498717 19:05:17 INFO - actual date: 1469498717 19:05:17 INFO - starting webserver on 'localhost:58779' 19:05:17 INFO - SUITE-START | Running 2 tests 19:05:17 INFO - TEST-START | dromaeo_css 19:05:17 INFO - operating with platform_type : linux_ 19:05:17 INFO - Initialising browser for dromaeo_css test... 19:05:17 INFO - TEST-INFO | started process 10816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_lV8r/profile http://localhost:58779/getInfo.html) 19:05:20 INFO - PROCESS | 10816 | JavaScript error: , line 0: uncaught exception: undefined 19:05:21 INFO - PROCESS | 10816 | __metrics Screen width/height:1600/1200 19:05:21 INFO - PROCESS | 10816 | colorDepth:24 19:05:21 INFO - PROCESS | 10816 | Browser inner width/height: 1024/697 19:05:21 INFO - PROCESS | 10816 | __metrics 19:05:22 INFO - PROCESS | 10816 | 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:05:22 INFO - PROCESS | 10816 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:05:23 INFO - TEST-INFO | 10816: exit 0 19:05:23 INFO - Browser initialized. 19:05:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:23 INFO - TEST-INFO | started process 10898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_lV8r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:35 INFO - PROCESS | 10898 | RSS: Main: 157691904 19:05:35 INFO - PROCESS | 10898 | 19:06:26 INFO - PROCESS | 10898 | 1469498786284 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:08:34 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58779/tests/dromaeo/cssquery-ext.html) 19:08:35 INFO - PROCESS | 10898 | RSS: Main: 267157504 19:08:35 INFO - PROCESS | 10898 | 19:11:38 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-ext.html (next: http://localhost:58779/tests/dromaeo/cssquery-jquery.html) 19:11:39 INFO - PROCESS | 10898 | RSS: Main: 249159680 19:11:39 INFO - PROCESS | 10898 | 19:14:41 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58779/tests/dromaeo/cssquery-mootools.html) 19:14:41 INFO - PROCESS | 10898 | RSS: Main: 226373632 19:14:41 INFO - PROCESS | 10898 | 19:17:43 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58779/tests/dromaeo/cssquery-prototype.html) 19:17:44 INFO - PROCESS | 10898 | RSS: Main: 228544512 19:17:44 INFO - PROCESS | 10898 | 19:20:47 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58779/tests/dromaeo/cssquery-yui.html) 19:20:47 INFO - PROCESS | 10898 | RSS: Main: 187015168 19:20:47 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | Cycle 1(1): loaded http://localhost:58779/tests/dromaeo/cssquery-yui.html (next: http://localhost:58779/tests/dromaeo/cssquery-dojo.html) 19:23:50 INFO - PROCESS | 10898 | RSS: Main: 266055680 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | __start_tp_report 19:23:50 INFO - PROCESS | 10898 | _x_x_mozilla_page_load 19:23:50 INFO - PROCESS | 10898 | _x_x_mozilla_page_load_details 19:23:50 INFO - PROCESS | 10898 | |i|pagename|runs| 19:23:50 INFO - PROCESS | 10898 | |0;dojo.html;3034.575159477673;3042.300270937683;3080.1375614827843;3083.629964404272;3097.674744151864;5083.542481176693;5118.232265160228;5304.734763261841;5376.327959005124;5389.73051347433;5371.57027437805;5393.325834270716;5414.052540805363;5480.123180291154;5511.9724401377935;4737.597304229144;4753.762311884409;4797.544233297831;4797.688150270239;4834.9033019339595;5030.320906677606;5031.144705400073;5038.622103342245;5075.822346217883;5079.339685840836;4933.80264789408;4940.08608407444;4977.527134922177;4978.502149785028;4996.725180115092;4772.49888761682;4809.951900480985;4814.422269327668;4847.442544107437;4854.101991131617;4814.66297359185;4817.590504807095;4821.325014497938;4824.059308434857;4826.420829500483;5193.039287731744;5245.449227831099;5261.736913154327;5272.393674727378;5285.603579731497;5679.744411501492;5689.118186681071;5694.914576281359;5750.82747517571;5766.106253530667;5871.1193321001765;5876.676782776945;5879.794207202727;5884.558658100659;5891.410858914117;5068.543831055186;5341.786328546815;5422.810201642924;5477.890442191134;5479.369872464677;6013.428724271187;6019.067044608093;6027.005544085177;6032.849178770478;6036.577439579188;5725.885482290331;5729.512991395694;5759.222504961776;5774.191613174159;5775.855603609859;5448.591355648342;5645.915311270334;5720.2849643794525;5732.598718089777;5861.944849927054;5681.744321505542;5683.261176047087;5683.829485115453;5688.77244910199;5712.80005199816;5695.971520142372;5715.228444159985;5724.914126288026;5733.455321744427;5735.541156707453;4261.936070958938;4298.247806633826;4364.1271745650365;4370.541093185233;4375.256206444912;3877.3796192609047;3908.687305015592;3911.2959667259597;3936.9212615747524;3949.0324870406935;5438.483344082306;5482.972585137129;5487.286652735119;5492.505674489315;5494.066008778437;5432.972835135799;5564.777408903598;5609.747561359749;5798.362180160179;5861.0915308127305;5329.813456529003;5342.225377320345;5349.705766182898;5358.598105142052;5368.8657783554945;4825.469198388175;4828.517148285214;4831.0820944020525;4832.44426890912;4877.097736918681;5758.827235182951;5769.567282453832;5826.76692932278;5869.266341707286;5877.382874798084;5623.550115990629;5632.5212356950115;5643.887122257614;5678.432156784289;5700.315962084576;5834.38738932406;5840.591158618856;5847.415258474119;5848.327442344185;5857.121431785266;5370.731463426891;5506.284183056177;5539.833804985857;5590.636608620427;5631.183478395692;5741.167530708108;5786.826395208151;5791.855203619774;5797;5838.474537291664;5611.494965453129;5617.634853734494;5622.522085622604;5638.830835074954;5646.774129034792;5379.946200537945;5399.271098401822;5399.865003374947;5541.362743284574;5617.662940223599;5444.8094316698725;5464.3442786865835;5468.425815289496;5470.234167216513;5514.972425137848;5463.699496527729;5468.7539060741565;5500.339959204921;5512.586556008396;5515.145152501369;5334.253204551288;5396.028714831368;5397.325334333208;5458;5537.031019571639 19:23:50 INFO - PROCESS | 10898 | |1;ext.html;593.7476572456708;613.3345320327445;635.9459445947093;637.4486069549838;651.3584119642148;31685.524717129232;45713.54286457135;46827.76586117064;46833.99999999991;46849.29726054112;47093.764531177294;47348.76325618367;47375;47405.762971185184;47448.52551474484;8088.393370497207;8982.86525702115;9133.862992055092;9142.451452912814;10683.946580267087;10489.213309001818;10891.509882055287;10898;10904.182186336056;10905.781884362308;10930.726731831688;11046.889531104707;11050.502727377247;11053.557857685722;11060.336379817236;10799.2440529163;10864;10916.235863489559;10923.180761442924;10933.343999360064;10759.83860242097;10781.83827242584;10838.891611083945;10862.78274434507;10867.565297388095;43651;43781.78109109466;44001.77999110016;44048;44056.559434405564;3535.0985498697924;3682.171511409938;3901.726879118463;3907.98046009771;4174.749515029108;33329.50005749916;33806.49290260648;34087.65912340894;34128.82935585331;35145.29709405823;4298.78506074695;4455.17579247837;4461.553844615545;4567.703099298535;4582.564656357641;360225;361060.19469902746;361924;362342;362603;59514.404855951754;59800;59868.10197847036;59875.401245986985;60008.39991600028;62379.37620623827;62440.68779656073;62457.68771156206;62529.374706253264;62552.68723656353;14502.1298722077;14724.779128313085;14749.115053096848;14752.926235368968;14765.261736913111;10608.257421980541;11254.15593830466;11261.66215013551;11335.263207891461;11541.36522491271;16755.497335079966;16795;16832.495025149266;16868.32526698943;17018.744718829228;5931.9703401483575;5953.136795164677;5979.701014949235;6039.909401358983;6152.507799376039;950.4629884115452;1037.4916291017498;1101.9614313499148;1131.3212072756444;1169.736809217936;32774.8361258197;33505.329893402486;33570;33862.83068584641;34223.14442138966;1077.7952189084049;1090.487470888681;1137.6587023892798;1179.8643156037165;1189.6668932698858;16613.50159495217;17694.017935747564;17811.46565603034;17813.287468501374;17915;551760;875897;888999;894126;895473;62260;63018;63126.36873631205;63129;63191.6840415795;1220.6948262934266;1300.1613958996206;1330.7405056013984;1332.247280286635;1373.0525937103366;32334.83832580822;32747.181320467178;35206.64793352034;35434.822825885705;35728.64271357357;55703;56591.71704141453;56602;56732.71633641805;56843.715781420826;557852;562312;565082;565738;566346.3365366294;36501.904942851754;37248.44127338038;47046.76476617595;47207.29189062236;47982.76008619935;50149.74925125351;51137.48862511327;51282.48717512777;51319.23021154611;55474.167887480915;42547.36178957256;42945.785271073444;44639.77680111579;47268.7636561815;47899.5210047909;44672.77663611791;45495.31757023581;45571.316430254235;46438.76780616075;47328;45615;46395.304070438295;47102.528974709814;47168;47202.05595888132;38490.23019539537;40393.39409908795;41451.37822932598;41575.75272741823;42358.78820606;30881.536776947913;31060.378792424475;31071.378572427973;31192;31745.8412707935 19:23:50 INFO - PROCESS | 10898 | |2;jquery.html;380.96571308582224;389.2802672670491;394.75525174391873;398.84843759371444;414.316377976339;14476.5657030289;18743.812561874376;19056;20651.07070181842;20685.482862928435;19157.616847663074;19227.173418525254;19467.610647787034;20476.69284960727;20584.8970755146;5785.913211301823;5960.612560183596;5974.3428222895445;5986.401359864;6009.909851352233;4265.8080386382535;5836.328822185461;5929.199558059671;6385.808425747235;6716.361945615183;6660.333966603349;6682.164729408824;6729.899051514231;6732.293109223535;6740.932590674104;6335.239771227436;6530.183727034121;6540.967295163494;6549.34506549346;6561.40947314744;5213.4004589472315;5476.945230547723;5758.078707406837;5766.336871259817;5770.7691692332255;14172.858271417257;14202.289885505683;14292.857071429256;14410.207438590873;14453.060551064253;2194.9341519754435;2277.248507992375;2293.9770602294097;2357.9882100589557;2365.66880636711;10217.846732299022;10788.352698838095;10927.508262128144;11847;15501.22493875313;1899.477643647994;1993.431871916497;2014.869033512817;2035.7557093148916;2084.5830833833293;76963;79538;81995.5900220501;84825.99999999939;85987.14012859853;10819.188560857967;10987.945060274647;11025.503852326665;11357.772844543228;11412;15358.692826143415;15539.611509712347;16011.919940400223;16027.599310017344;16052.75920861188;7841.84349303946;7932.977090841799;7952.403569732293;7969.481983671159;8082.959585202037;7339.559626422431;7364.9746319761425;7375.704971801175;7497.587632680255;7552.533138565111;4798.2082956311815;4803.159447096814;4828.95171048285;5004.024215277986;5006.872079366255;1933.5262860599244;1960.8235258826774;1973.2832435780963;1992.571597106629;2014.8488863335308;909.286210324905;1054.272551939175;1064.526285802826;1075.0539525217757;1089.1123734156638;20061.498462538555;20850.270240541813;20925.26761563338;20956.851777866315;21084.578308433745;957.5738796235747;958.6932181701928;961.990380096204;977.4135518688872;981.7335637028153;11102.555897764161;11330.94334528322;11507.309561426342;11525.769484610428;11530.94234528822;418001;516097;529505;530074;531968;57691.42308576944;75983.62008189924;78243;87957.56021219853;90044.09955900357;929.2705226397246;935.3452583191793;1012.448215722433;1014.7868947521104;1041.1774697988656;17982.730259045864;18301.54246143857;18700.78444901077;18822.905885470485;19041.809581904003;43189.13621727611;43285.7757026164;43384;44451.11097778091;45543.77228113838;61224;61444;61652;62473;63053;8224.835503289782;8495.192956669107;8543.10297418787;8553.700620478503;8660.956695216484;8762.430442021248;12157.635270941886;12701.618951431472;13089;13158.407871645608;11190.552377905118;11423.771524569296;11626.88373116258;11650.067994560584;12010.39948002579;10800.945995269973;11200.831987520356;11203.383813890314;11313.7737245253;11334.716632084264;6307.810765677037;8891.73324800257;11196.328220306808;11358.375289359165;11915.463804128662;8213.178682131978;8227.341812654853;8459.957700211706;8478.321734261368;8507.447015943944;10885.673429797118;11126.720427150658;11203.775924481628;11204.327740335606;11412.429378530875 19:23:50 INFO - PROCESS | 10898 | |3;mootools.html;1438.805761222235;1511.4407669162408;1623.4642567952576;1718.1752758675843;1787.6603445345393;8169;8704.477731336125;8706.782330441742;8714.389992700506;8716.259117974972;7078.85842283154;7251.528650637718;7270.672819723112;7477.25227477252;8476.872846907301;2310.1683393978196;2384.129792625688;2392.1627430399394;2402.315340128064;2405.2062819269686;2389.2712722619594;2412.16780210827;2424.8423852449623;2430.0765709030543;2439.5486834935505;2390.8087353011715;2411.3730430088126;2415.4323733922515;2415.7342692303832;2419.443527988564;2355.2698663414394;2357.03361621736;2359.1860808021206;2360.9409764755846;2368.952620947571;2315.178111770331;2349.2247558305717;2350.2361732437025;2351.870647114408;2362.7164740231283;9002.369834111614;9002.549872506414;9035.32235082365;9044.321675874337;9088.50013249271;5216.087184742692;5280.762365693553;5319.973400132974;5346.492083252085;5396.43337449566;3377.3583019226267;3484.6515348465205;3656.597774244831;3656.744027918047;3658.432942893856;1196.4316949449028;1201.1231800785476;1209.0931801149138;1212.6847019774834;1234.9135560510767;12340.629781106582;12365.93817030918;12367.257964522067;12400.317982510958;12416.317102559356;4769.165396055676;4788.850675837773;4808.134535783593;4903.043906438282;4929.802807887644;10453.163746900382;10463.790724185474;10467.528961196613;10467.633632822966;10468.371897686164;5314.813981510629;5341.7062061586985;5351.946480535223;5355;5357.651752636066;4805.27920811874;4871.853844384674;4879.463259041502;4879.902401951941;4919.335889654851;3881.204353107606;3884.1454879926373;3941.467901833273;3981.044549308145;4000.6799456043445;1184.6209213051914;1185.5554167187304;1186.5313201285444;1189.3280296632374;1202.4348556178581;862;962.7785609309758;964.8504481805331;986.1026465915982;991.5984026469291;6011;6058.454739073504;6161.568690191643;6225.159603453566;6331.746730130835;471.89382388962207;474.7863461442296;476.6663335665048;483.37161689803116;484.8957474143076;4078.632923036941;4116.9794151029655;4216.9789151054665;4240.194363071068;4297.720648157922;10522.316049456915;10830.620928267474;10917.39954302505;10920.781584368428;10941.781164376827;10233.99999999985;10818.67543973682;10832.566697332019;10842.891571084347;10844.728881778019;7995.840083198304;8169.060558035783;8359.498430094092;8362.8327433451;8379.036410812712;5664.150377443417;5902.940970590411;5963.91054134197;5994.400559943971;6031.095335699505;9960.688058748496;9995.250356223167;10134.087932086148;10165.034321739422;10177.491125443847;10241.129503991946;10254.58981640726;10320.329178603668;10334.793304133726;10437.58249670035;7131.964340178266;8142.3486121111355;8358.414910956419;8459.154084591737;8644.870326944974;8379.622916968628;8686.78283042929;8736.563171841255;8754.91245087541;8757.255633271243;7542.132654744774;7649.196834332315;7663.923360766321;7895.881561776463;7944.364450843803;7555.546667199986;7662.655180516778;7685.154632990255;7873.724419645285;7950.165232650488;7060.435165186876;7101.964490177516;7165.713371465083;7185.820354491179;7263.0921134858145;5085.7457127144235;5203.73981300941;5225.268462415189;5246.580273578181;5358.651687640291;5119.590432765444;5198.350206224222;5201.193814958688;5275.841724748264;5355.70543620089 19:23:50 INFO - PROCESS | 10898 | |4;prototype.html;330.30635665103284;332.0817938400323;342.4418198336711;344.1825664047887;346.2244572158363;5276.788928442863;5313.495217954298;5323.60072994525;5344.198370244465;5350.180938480916;4991.475895031024;5065.088284108859;5205.635605507616;5227.869303267411;5242.344706911636;4171.207470580595;4182.8745137645765;4215.747055176684;4234.9364759528635;4239.4986957694955;4188.4136220929095;4210.3894935234375;4223.429836972015;4230.111676547913;4243.469566304212;3941.0935484838506;4024.2756303865294;4124.237016152007;4138.6482149017365;4170.47869016373;4132.214879172978;4143.150654115899;4145.1916876209;4153.252414565377;4155.833766649331;3696.244283965122;3703.925921481582;3708.9258214835822;3720.981395093007;3721;5039.168537191359;5047.343845300087;5069.543741063322;5100.118433085295;5185.714785686786;4685.812567497296;4697.765111744433;4707.270373092142;4711.693739906929;4770.044281844427;5402.405735369106;5451.781928722847;5459.836204913859;5463.344398672145;5494.780208791643;3879.8836034919;4013.6789056875673;4041.2725709372303;4049.7975101245115;4052.2098190852794;5641.661500309953;5687.772489100431;5689.914651280193;5709;5715.714214289269;4148.668106551469;4151.6886233532605;4153.605407486284;4157.875263742093;4162.231051802972;3961.742486738353;4123.278426275389;4125.876223713293;4225.514065882401;4234.661227101825;4682.742449165328;4694.413198350207;4698.88252793676;4714.481407045222;4726.976365118221;5531.9723401382735;5539.307586551681;5544.61187716856;5557.277553918046;5578.832635020955;1344.5159742492694;1353.3098119958893;1399.7200559888063;1408.4929425406845;1423.2172305232289;920.4293338130402;948.9240860731124;959.6449313753956;961.8268711631973;964.7313782376153;5283.973580132075;5292.206169074592;5303.416624171338;5310.203469479609;5340.198970154508;5571.275734154615;5595.8601034973635;5599.32808063035;5611.9438805612235;5617.129344951539;5190.8183213587345;5397.78408863641;5435.695433096029;5436.809711660073;5459.945400546023;3001.9099427017222;3012.3071693510615;3016.3816417634334;3032.9393412132076;3036.9848150759103;5692.9146062809095;5848.883022339614;5849.5027922626205;5853.912191317134;5882.147123656035;5718.428157184248;5740.311162660508;5747.85630359236;5764.279465066867;5774.82675519735;5819.970900145472;5821.825345239649;5838.182654428383;5859.296884373903;5887.499562537232;5426.294581704511;5624.634398764068;5679.148127780701;5691.3170419549915;5702.6293290935955;5543.170753651205;5580.441955804387;5585.301837270341;5587.525060369914;5612.438756124355;5784.917429725211;5842.211301474246;5865.296164460292;5866.882662346815;5938.5259623120955;4032.939505907355;4048.473698419187;4053;4059.5737447568763;4070.816813243352;5677.801276955287;5684.431556844283;5699.2590963174525;5713.22871412354;5724.484796368347;5251.52736253739;5448.863778405572;5511.614187007031;5539.806106786243;5570.192322113352;5466;5471.835844924659;5502.422245664147;5509.972450137884;5521.5306698931045;5210.525000624673;5366.497380733401;5389.380221274603;5528.253685752372;5528.253685752372;5053.84838454847;5183.896322073462;5551.583631227755;5557.499825015768;5587.7485513152815;5413.56691464674;5419.376771671308;5426.593005524523;5440.945590544044;5461.15352120422 19:23:50 INFO - PROCESS | 10898 | |5;yui.html;785.1990969211405;813.4549851599428;813.6663967773212;830.2610676497922;832.4173078844808;15415.15216663083;16054.759178612301;16635.50093497194;16780.41268555599;16781.83218167818;14721.779173312381;14835.851641483581;14844.33200505977;14914.17972011539;14918.328675209614;808.9514629122272;831.9168083191693;835.2357592802579;835.7826964989085;835.9164083591653;679.2426444514356;802.2018091998469;824.1346586084617;831.4595512916592;833.3374966901298;859.5702148925537;860.0324634785866;861.6294993152973;861.6811779641541;862.2326129744501;848.4061157189992;856.4903882190087;857.4555157475017;857.8370109679141;858.6393714639867;508.9109405853961;605.1135087097423;617.3086143519287;619.6313193649771;621.2389822467486;15522.223888805627;15559.688806223925;15562.922185389114;15564.221788910509;15609.375624974988;13966;14276.643083922881;14619.269036548236;14723;14804.333804978802;11918.523259069627;12109;12169.269843809312;12238.632841014783;12273.509059637603;4419.508932359651;4481.731096134243;4545.818167273305;4577.899080160287;4674.485806561275;77142.22857771406;78672;80153;81804.59097704533;83743.58128209382;11680.123990700562;11751.706207344885;11791.35147566875;11936;11939.46272417726;22195;22324.55350892973;22326.665100023514;22326.77673223247;22368;8563.95718021406;8852.513111778786;8997.055309192572;9031.63873445068;9209.63161473547;4635.564758215542;4663.323818046364;4684.859454216379;4780.402449693788;4892.315075889378;3415.777974431654;3503.3343664703625;3506.4214404622953;3507.596626387998;3516.5780106387397;597.4533302028682;603.6317846113867;649.3701109923367;678.2098854834162;679.1578442731077;668.669008840627;677.552815142004;687.9105716256954;698.9266127056586;703.6587255181233;9215.63137474507;9869.21046316293;9892.35699679533;10358.601588785568;10837.674869753762;640.6124294801671;728.3408515293668;731.5208538407352;775.9418043646749;782.2451334462271;4902.338184345068;5074.873128171826;5130.48695130484;5180.248863914711;5191.9480805192225;101292;129217;131288.3435582816;132790.33604832107;132926;108548.4572577132;110739.89260107456;114373.4281328588;114473.4276328613;116585;99468.5026574877;101416;102477;102649.30130240113;105605;9495.14543691071;9750.902490975282;9770.706878793648;9809.656662016796;9823.410595364301;57010;57072;57222.42777572171;57846;59247;81371;85388.57305713432;85558.57220713857;87396;88399;12099.637010889688;12757.808632870328;12774.552890648783;13185.934070329587;13391.799123013358;13830.239336836168;14070.085444446488;14368.56597127461;14554.27228638585;14705.264736763333;13724.65688357759;13771.793423098861;13936.930315348358;14183.432662693376;14448.171234623043;12146.878531214576;12309.871942611091;12465.439055242354;12818.743625127632;13721.931390342985;13165.407556659782;13528.86471135276;14189.361478733688;14566.563003109924;14608.561743147722;11825.940870295593;11904.464299106388;11995.220310679779;12004.819927701266;12404.317762523147;10964.287321324407;12279.938600306941;12346.320952347707;12775.041871859461;12803.10378273512 19:23:50 INFO - PROCESS | 10898 | __end_tp_report 19:23:50 INFO - PROCESS | 10898 | __start_cc_report 19:23:50 INFO - PROCESS | 10898 | _x_x_mozilla_cycle_collect,990 19:23:50 INFO - PROCESS | 10898 | __end_cc_report 19:23:50 INFO - PROCESS | 10898 | __startTimestamp1469499830550__endTimestamp 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | ------- Summary: start ------- 19:23:50 INFO - PROCESS | 10898 | Number of tests: 6 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#0] dojo.html Cycles:165 Average:5302.20 Median:5470.23 stddev:609.25 (11.1%) stddev-sans-first:584.57 19:23:50 INFO - PROCESS | 10898 | Values: 3034.6 3042.3 3080.1 3083.6 3097.7 5083.5 5118.2 5304.7 5376.3 5389.7 5371.6 5393.3 5414.1 5480.1 5512.0 4737.6 4753.8 4797.5 4797.7 4834.9 5030.3 5031.1 5038.6 5075.8 5079.3 4933.8 4940.1 4977.5 4978.5 4996.7 4772.5 4810.0 4814.4 4847.4 4854.1 4814.7 4817.6 4821.3 4824.1 4826.4 5193.0 5245.4 5261.7 5272.4 5285.6 5679.7 5689.1 5694.9 5750.8 5766.1 5871.1 5876.7 5879.8 5884.6 5891.4 5068.5 5341.8 5422.8 5477.9 5479.4 6013.4 6019.1 6027.0 6032.8 6036.6 5725.9 5729.5 5759.2 5774.2 5775.9 5448.6 5645.9 5720.3 5732.6 5861.9 5681.7 5683.3 5683.8 5688.8 5712.8 5696.0 5715.2 5724.9 5733.5 5735.5 4261.9 4298.2 4364.1 4370.5 4375.3 3877.4 3908.7 3911.3 3936.9 3949.0 5438.5 5483.0 5487.3 5492.5 5494.1 5433.0 5564.8 5609.7 5798.4 5861.1 5329.8 5342.2 5349.7 5358.6 5368.9 4825.5 4828.5 4831.1 4832.4 4877.1 5758.8 5769.6 5826.8 5869.3 5877.4 5623.6 5632.5 5643.9 5678.4 5700.3 5834.4 5840.6 5847.4 5848.3 5857.1 5370.7 5506.3 5539.8 5590.6 5631.2 5741.2 5786.8 5791.9 5797.0 5838.5 5611.5 5617.6 5622.5 5638.8 5646.8 5379.9 5399.3 5399.9 5541.4 5617.7 5444.8 5464.3 5468.4 5470.2 5515.0 5463.7 5468.8 5500.3 5512.6 5515.1 5334.3 5396.0 5397.3 5458.0 5537.0 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#1] ext.html Cycles:180 Average:73922.41 Median:22875.25 stddev:165751.03 (724.6%) stddev-sans-first:166124.57 19:23:50 INFO - PROCESS | 10898 | Values: 593.7 613.3 635.9 637.4 651.4 31685.5 45713.5 46827.8 46834.0 46849.3 47093.8 47348.8 47375.0 47405.8 47448.5 8088.4 8982.9 9133.9 9142.5 10683.9 10489.2 10891.5 10898.0 10904.2 10905.8 10930.7 11046.9 11050.5 11053.6 11060.3 10799.2 10864.0 10916.2 10923.2 10933.3 10759.8 10781.8 10838.9 10862.8 10867.6 43651.0 43781.8 44001.8 44048.0 44056.6 3535.1 3682.2 3901.7 3908.0 4174.7 33329.5 33806.5 34087.7 34128.8 35145.3 4298.8 4455.2 4461.6 4567.7 4582.6 360225.0 361060.2 361924.0 362342.0 362603.0 59514.4 59800.0 59868.1 59875.4 60008.4 62379.4 62440.7 62457.7 62529.4 62552.7 14502.1 14724.8 14749.1 14752.9 14765.3 10608.3 11254.2 11261.7 11335.3 11541.4 16755.5 16795.0 16832.5 16868.3 17018.7 5932.0 5953.1 5979.7 6039.9 6152.5 950.5 1037.5 1102.0 1131.3 1169.7 32774.8 33505.3 33570.0 33862.8 34223.1 1077.8 1090.5 1137.7 1179.9 1189.7 16613.5 17694.0 17811.5 17813.3 17915.0 551760.0 875897.0 888999.0 894126.0 895473.0 62260.0 63018.0 63126.4 63129.0 63191.7 1220.7 1300.2 1330.7 1332.2 1373.1 32334.8 32747.2 35206.6 35434.8 35728.6 55703.0 56591.7 56602.0 56732.7 56843.7 557852.0 562312.0 565082.0 565738.0 566346.3 36501.9 37248.4 47046.8 47207.3 47982.8 50149.7 51137.5 51282.5 51319.2 55474.2 42547.4 42945.8 44639.8 47268.8 47899.5 44672.8 45495.3 45571.3 46438.8 47328.0 45615.0 46395.3 47102.5 47168.0 47202.1 38490.2 40393.4 41451.4 41575.8 42358.8 30881.5 31060.4 31071.4 31192.0 31745.8 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#2] jquery.html Cycles:180 Average:29068.38 Median:392.02 stddev:83376.05 (21268.4%) stddev-sans-first:83582.11 19:23:50 INFO - PROCESS | 10898 | Values: 381.0 389.3 394.8 398.8 414.3 14476.6 18743.8 19056.0 20651.1 20685.5 19157.6 19227.2 19467.6 20476.7 20584.9 5785.9 5960.6 5974.3 5986.4 6009.9 4265.8 5836.3 5929.2 6385.8 6716.4 6660.3 6682.2 6729.9 6732.3 6740.9 6335.2 6530.2 6541.0 6549.3 6561.4 5213.4 5476.9 5758.1 5766.3 5770.8 14172.9 14202.3 14292.9 14410.2 14453.1 2194.9 2277.2 2294.0 2358.0 2365.7 10217.8 10788.4 10927.5 11847.0 15501.2 1899.5 1993.4 2014.9 2035.8 2084.6 76963.0 79538.0 81995.6 84826.0 85987.1 10819.2 10987.9 11025.5 11357.8 11412.0 15358.7 15539.6 16011.9 16027.6 16052.8 7841.8 7933.0 7952.4 7969.5 8083.0 7339.6 7365.0 7375.7 7497.6 7552.5 4798.2 4803.2 4829.0 5004.0 5006.9 1933.5 1960.8 1973.3 1992.6 2014.8 909.3 1054.3 1064.5 1075.1 1089.1 20061.5 20850.3 20925.3 20956.9 21084.6 957.6 958.7 962.0 977.4 981.7 11102.6 11330.9 11507.3 11525.8 11530.9 418001.0 516097.0 529505.0 530074.0 531968.0 57691.4 75983.6 78243.0 87957.6 90044.1 929.3 935.3 1012.4 1014.8 1041.2 17982.7 18301.5 18700.8 18822.9 19041.8 43189.1 43285.8 43384.0 44451.1 45543.8 61224.0 61444.0 61652.0 62473.0 63053.0 8224.8 8495.2 8543.1 8553.7 8661.0 8762.4 12157.6 12701.6 13089.0 13158.4 11190.6 11423.8 11626.9 11650.1 12010.4 10800.9 11200.8 11203.4 11313.8 11334.7 6307.8 8891.7 11196.3 11358.4 11915.5 8213.2 8227.3 8460.0 8478.3 8507.4 10885.7 11126.7 11203.8 11204.3 11412.4 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#3] mootools.html Cycles:180 Average:5821.85 Median:484.13 stddev:3294.31 (680.5%) stddev-sans-first:3287.09 19:23:50 INFO - PROCESS | 10898 | Values: 1438.8 1511.4 1623.5 1718.2 1787.7 8169.0 8704.5 8706.8 8714.4 8716.3 7078.9 7251.5 7270.7 7477.3 8476.9 2310.2 2384.1 2392.2 2402.3 2405.2 2389.3 2412.2 2424.8 2430.1 2439.5 2390.8 2411.4 2415.4 2415.7 2419.4 2355.3 2357.0 2359.2 2360.9 2369.0 2315.2 2349.2 2350.2 2351.9 2362.7 9002.4 9002.5 9035.3 9044.3 9088.5 5216.1 5280.8 5320.0 5346.5 5396.4 3377.4 3484.7 3656.6 3656.7 3658.4 1196.4 1201.1 1209.1 1212.7 1234.9 12340.6 12365.9 12367.3 12400.3 12416.3 4769.2 4788.9 4808.1 4903.0 4929.8 10453.2 10463.8 10467.5 10467.6 10468.4 5314.8 5341.7 5351.9 5355.0 5357.7 4805.3 4871.9 4879.5 4879.9 4919.3 3881.2 3884.1 3941.5 3981.0 4000.7 1184.6 1185.6 1186.5 1189.3 1202.4 862.0 962.8 964.9 986.1 991.6 6011.0 6058.5 6161.6 6225.2 6331.7 471.9 474.8 476.7 483.4 484.9 4078.6 4117.0 4217.0 4240.2 4297.7 10522.3 10830.6 10917.4 10920.8 10941.8 10234.0 10818.7 10832.6 10842.9 10844.7 7995.8 8169.1 8359.5 8362.8 8379.0 5664.2 5902.9 5963.9 5994.4 6031.1 9960.7 9995.3 10134.1 10165.0 10177.5 10241.1 10254.6 10320.3 10334.8 10437.6 7132.0 8142.3 8358.4 8459.2 8644.9 8379.6 8686.8 8736.6 8754.9 8757.3 7542.1 7649.2 7663.9 7895.9 7944.4 7555.5 7662.7 7685.2 7873.7 7950.2 7060.4 7102.0 7165.7 7185.8 7263.1 5085.7 5203.7 5225.3 5246.6 5358.7 5119.6 5198.4 5201.2 5275.8 5355.7 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#4] prototype.html Cycles:180 Average:4659.32 Median:5318.55 stddev:1354.20 (25.5%) stddev-sans-first:1318.44 19:23:50 INFO - PROCESS | 10898 | Values: 330.3 332.1 342.4 344.2 346.2 5276.8 5313.5 5323.6 5344.2 5350.2 4991.5 5065.1 5205.6 5227.9 5242.3 4171.2 4182.9 4215.7 4234.9 4239.5 4188.4 4210.4 4223.4 4230.1 4243.5 3941.1 4024.3 4124.2 4138.6 4170.5 4132.2 4143.2 4145.2 4153.3 4155.8 3696.2 3703.9 3708.9 3721.0 3721.0 5039.2 5047.3 5069.5 5100.1 5185.7 4685.8 4697.8 4707.3 4711.7 4770.0 5402.4 5451.8 5459.8 5463.3 5494.8 3879.9 4013.7 4041.3 4049.8 4052.2 5641.7 5687.8 5689.9 5709.0 5715.7 4148.7 4151.7 4153.6 4157.9 4162.2 3961.7 4123.3 4125.9 4225.5 4234.7 4682.7 4694.4 4698.9 4714.5 4727.0 5532.0 5539.3 5544.6 5557.3 5578.8 1344.5 1353.3 1399.7 1408.5 1423.2 920.4 948.9 959.6 961.8 964.7 5284.0 5292.2 5303.4 5310.2 5340.2 5571.3 5595.9 5599.3 5611.9 5617.1 5190.8 5397.8 5435.7 5436.8 5459.9 3001.9 3012.3 3016.4 3032.9 3037.0 5692.9 5848.9 5849.5 5853.9 5882.1 5718.4 5740.3 5747.9 5764.3 5774.8 5820.0 5821.8 5838.2 5859.3 5887.5 5426.3 5624.6 5679.1 5691.3 5702.6 5543.2 5580.4 5585.3 5587.5 5612.4 5784.9 5842.2 5865.3 5866.9 5938.5 4032.9 4048.5 4053.0 4059.6 4070.8 5677.8 5684.4 5699.3 5713.2 5724.5 5251.5 5448.9 5511.6 5539.8 5570.2 5466.0 5471.8 5502.4 5510.0 5521.5 5210.5 5366.5 5389.4 5528.3 5528.3 5053.8 5183.9 5551.6 5557.5 5587.7 5413.6 5419.4 5426.6 5440.9 5461.2 19:23:50 INFO - PROCESS | 10898 | 19:23:50 INFO - PROCESS | 10898 | [#5] yui.html Cycles:180 Average:22704.32 Median:3968.04 stddev:33843.38 (852.9%) stddev-sans-first:33898.30 19:23:50 INFO - PROCESS | 10898 | Values: 785.2 813.5 813.7 830.3 832.4 15415.2 16054.8 16635.5 16780.4 16781.8 14721.8 14835.9 14844.3 14914.2 14918.3 809.0 831.9 835.2 835.8 835.9 679.2 802.2 824.1 831.5 833.3 859.6 860.0 861.6 861.7 862.2 848.4 856.5 857.5 857.8 858.6 508.9 605.1 617.3 619.6 621.2 15522.2 15559.7 15562.9 15564.2 15609.4 13966.0 14276.6 14619.3 14723.0 14804.3 11918.5 12109.0 12169.3 12238.6 12273.5 4419.5 4481.7 4545.8 4577.9 4674.5 77142.2 78672.0 80153.0 81804.6 83743.6 11680.1 11751.7 11791.4 11936.0 11939.5 22195.0 22324.6 22326.7 22326.8 22368.0 8564.0 8852.5 8997.1 9031.6 9209.6 4635.6 4663.3 4684.9 4780.4 4892.3 3415.8 3503.3 3506.4 3507.6 3516.6 597.5 603.6 649.4 678.2 679.2 668.7 677.6 687.9 698.9 703.7 9215.6 9869.2 9892.4 10358.6 10837.7 640.6 728.3 731.5 775.9 782.2 4902.3 5074.9 5130.5 5180.2 5191.9 101292.0 129217.0 131288.3 132790.3 132926.0 108548.5 110739.9 114373.4 114473.4 116585.0 99468.5 101416.0 102477.0 102649.3 105605.0 9495.1 9750.9 9770.7 9809.7 9823.4 57010.0 57072.0 57222.4 57846.0 59247.0 81371.0 85388.6 85558.6 87396.0 88399.0 12099.6 12757.8 12774.6 13185.9 13391.8 13830.2 14070.1 14368.6 14554.3 14705.3 13724.7 13771.8 13936.9 14183.4 14448.2 12146.9 12309.9 12465.4 12818.7 13721.9 13165.4 13528.9 14189.4 14566.6 14608.6 11825.9 11904.5 11995.2 12004.8 12404.3 10964.3 12279.9 12346.3 12775.0 12803.1 19:23:50 INFO - PROCESS | 10898 | -------- Summary: end -------- 19:23:50 INFO - PROCESS | 10898 | 19:23:51 INFO - TEST-INFO | 10898: exit 0 19:23:51 INFO - TEST-OK | dromaeo_css | took 1114097ms 19:23:51 INFO - TEST-START | kraken 19:23:51 INFO - operating with platform_type : linux_ 19:23:51 INFO - Initialising browser for kraken test... 19:23:51 INFO - TEST-INFO | started process 11093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjUe_mQ/profile http://localhost:58779/getInfo.html) 19:23:54 INFO - PROCESS | 11093 | JavaScript error: , line 0: uncaught exception: undefined 19:23:55 INFO - PROCESS | 11093 | __metrics Screen width/height:1600/1200 19:23:55 INFO - PROCESS | 11093 | colorDepth:24 19:23:55 INFO - PROCESS | 11093 | Browser inner width/height: 1024/697 19:23:55 INFO - PROCESS | 11093 | __metrics 19:23:56 INFO - PROCESS | 11093 | 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:23:56 INFO - PROCESS | 11093 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:56 INFO - PROCESS | 11093 | console.error: PushService: 19:23:56 INFO - PROCESS | 11093 | stateChangeProcessEnqueue: Error transitioning state 19:23:56 INFO - PROCESS | 11093 | UnknownError 19:23:57 INFO - TEST-INFO | 11093: exit 0 19:23:57 INFO - Browser initialized. 19:23:57 INFO - Running cycle 1/1 for kraken test... 19:23:57 INFO - TEST-INFO | started process 11172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjUe_mQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:08 INFO - PROCESS | 11172 | RSS: Main: 157962240 19:24:08 INFO - PROCESS | 11172 | 19:24:11 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58779/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:12 INFO - PROCESS | 11172 | RSS: Main: 214339584 19:24:12 INFO - PROCESS | 11172 | 19:24:14 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58779/tests/kraken/driver.html?testName=audio-dft) 19:24:15 INFO - PROCESS | 11172 | RSS: Main: 193175552 19:24:15 INFO - PROCESS | 11172 | 19:24:18 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58779/tests/kraken/driver.html?testName=audio-fft) 19:24:19 INFO - PROCESS | 11172 | RSS: Main: 271810560 19:24:19 INFO - PROCESS | 11172 | 19:24:21 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58779/tests/kraken/driver.html?testName=audio-oscillator) 19:24:21 INFO - PROCESS | 11172 | RSS: Main: 180912128 19:24:21 INFO - PROCESS | 11172 | 19:24:24 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:24 INFO - PROCESS | 11172 | RSS: Main: 185081856 19:24:24 INFO - PROCESS | 11172 | 19:24:27 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58779/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:28 INFO - PROCESS | 11172 | RSS: Main: 220266496 19:24:28 INFO - PROCESS | 11172 | 19:24:31 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58779/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:32 INFO - PROCESS | 11172 | RSS: Main: 221028352 19:24:32 INFO - PROCESS | 11172 | 19:24:34 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58779/tests/kraken/driver.html?testName=json-parse-financial) 19:24:35 INFO - PROCESS | 11172 | RSS: Main: 220864512 19:24:35 INFO - PROCESS | 11172 | 19:24:37 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:24:37 INFO - PROCESS | 11172 | RSS: Main: 185393152 19:24:37 INFO - PROCESS | 11172 | 19:24:39 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:24:39 INFO - PROCESS | 11172 | RSS: Main: 190484480 19:24:39 INFO - PROCESS | 11172 | 19:24:41 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:24:42 INFO - PROCESS | 11172 | RSS: Main: 196296704 19:24:42 INFO - PROCESS | 11172 | 19:24:45 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:24:45 INFO - PROCESS | 11172 | RSS: Main: 191254528 19:24:45 INFO - PROCESS | 11172 | 19:24:48 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:49 INFO - PROCESS | 11172 | RSS: Main: 193691648 19:24:49 INFO - PROCESS | 11172 | 19:24:50 INFO - PROCESS | 11172 | Cycle 1(1): loaded http://localhost:58779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58779/tests/kraken/driver.html?testName=ai-astar) 19:24:50 INFO - PROCESS | 11172 | RSS: Main: 245051392 19:24:50 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | __start_tp_report 19:24:51 INFO - PROCESS | 11172 | _x_x_mozilla_page_load 19:24:51 INFO - PROCESS | 11172 | _x_x_mozilla_page_load_details 19:24:51 INFO - PROCESS | 11172 | |i|pagename|runs| 19:24:51 INFO - PROCESS | 11172 | |0;ai-astar;102;110;110;110;109;110;109;109;110;109 19:24:51 INFO - PROCESS | 11172 | |1;audio-beat-detection;145;117;120;174;125;125;149;116;159;120 19:24:51 INFO - PROCESS | 11172 | |2;audio-dft;161;160;159;162;160;162;161;161;161;161 19:24:51 INFO - PROCESS | 11172 | |3;audio-fft;74;75;75;113;77;75;76;76;120;75 19:24:51 INFO - PROCESS | 11172 | |4;audio-oscillator;84;83;116;85;84;84;125;84;84;120 19:24:51 INFO - PROCESS | 11172 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;117;117;117 19:24:51 INFO - PROCESS | 11172 | |6;imaging-darkroom;146;146;146;146;145;146;146;146;146;146 19:24:51 INFO - PROCESS | 11172 | |7;imaging-desaturate;95;95;95;95;94;95;95;96;96;94 19:24:51 INFO - PROCESS | 11172 | |8;json-parse-financial;51;52;51;52;53;52;52;53;52;52 19:24:51 INFO - PROCESS | 11172 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;62;63;64 19:24:51 INFO - PROCESS | 11172 | |10;stanford-crypto-aes;76;76;76;76;84;76;75;75;85;80 19:24:51 INFO - PROCESS | 11172 | |11;stanford-crypto-ccm;126;120;119;135;124;127;121;120;166;127 19:24:51 INFO - PROCESS | 11172 | |12;stanford-crypto-pbkdf2;156;157;156;157;157;156;157;160;157;155 19:24:51 INFO - PROCESS | 11172 | |13;stanford-crypto-sha256-iterative;65;63;62;64;63;63;61;61;62;63 19:24:51 INFO - PROCESS | 11172 | __end_tp_report 19:24:51 INFO - PROCESS | 11172 | __start_cc_report 19:24:51 INFO - PROCESS | 11172 | _x_x_mozilla_cycle_collect,1642 19:24:51 INFO - PROCESS | 11172 | __end_cc_report 19:24:51 INFO - PROCESS | 11172 | __startTimestamp1469499890999__endTimestamp 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | ------- Summary: start ------- 19:24:51 INFO - PROCESS | 11172 | Number of tests: 14 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.44 (2.2%) stddev-sans-first:0.53 19:24:51 INFO - PROCESS | 11172 | Values: 102.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:135.00 stddev:20.35 (15.1%) stddev-sans-first:21.26 19:24:51 INFO - PROCESS | 11172 | Values: 145.0 117.0 120.0 174.0 125.0 125.0 149.0 116.0 159.0 120.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:24:51 INFO - PROCESS | 11172 | Values: 161.0 160.0 159.0 162.0 160.0 162.0 161.0 161.0 161.0 161.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:17.44 (23.2%) stddev-sans-first:18.15 19:24:51 INFO - PROCESS | 11172 | Values: 74.0 75.0 75.0 113.0 77.0 75.0 76.0 76.0 120.0 75.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.69 (21.1%) stddev-sans-first:18.31 19:24:51 INFO - PROCESS | 11172 | Values: 84.0 83.0 116.0 85.0 84.0 84.0 125.0 84.0 84.0 120.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:24:51 INFO - PROCESS | 11172 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:24:51 INFO - PROCESS | 11172 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:24:51 INFO - PROCESS | 11172 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 96.0 94.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 19:24:51 INFO - PROCESS | 11172 | Values: 51.0 52.0 51.0 52.0 53.0 52.0 52.0 53.0 52.0 52.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 19:24:51 INFO - PROCESS | 11172 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 64.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:76.00 stddev:3.75 (4.9%) stddev-sans-first:3.92 19:24:51 INFO - PROCESS | 11172 | Values: 76.0 76.0 76.0 76.0 84.0 76.0 75.0 75.0 85.0 80.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.50 stddev:14.03 (11.1%) stddev-sans-first:14.85 19:24:51 INFO - PROCESS | 11172 | Values: 126.0 120.0 119.0 135.0 124.0 127.0 121.0 120.0 166.0 127.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 19:24:51 INFO - PROCESS | 11172 | Values: 156.0 157.0 156.0 157.0 157.0 156.0 157.0 160.0 157.0 155.0 19:24:51 INFO - PROCESS | 11172 | 19:24:51 INFO - PROCESS | 11172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.01 19:24:51 INFO - PROCESS | 11172 | Values: 65.0 63.0 62.0 64.0 63.0 63.0 61.0 61.0 62.0 63.0 19:24:51 INFO - PROCESS | 11172 | -------- Summary: end -------- 19:24:51 INFO - PROCESS | 11172 | 19:24:52 INFO - TEST-INFO | 11172: exit 0 19:24:52 INFO - TEST-OK | kraken | took 60791ms 19:24:52 INFO - SUITE-END | took 1174s 19:24:52 INFO - Completed test suite (00:19:34) 19:24:52 INFO - javascript benchmark 19:24:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.575159477673, 3042.300270937683, 3080.1375614827843, 3083.629964404272, 3097.674744151864, 5083.542481176693, 5118.232265160228, 5304.734763261841, 5376.327959005124, 5389.73051347433, 5371.57027437805, 5393.325834270716, 5414.052540805363, 5480.123180291154, 5511.9724401377935, 4737.597304229144, 4753.762311884409, 4797.544233297831, 4797.688150270239, 4834.9033019339595, 5030.320906677606, 5031.144705400073, 5038.622103342245, 5075.822346217883, 5079.339685840836, 4933.80264789408, 4940.08608407444, 4977.527134922177, 4978.502149785028, 4996.725180115092, 4772.49888761682, 4809.951900480985, 4814.422269327668, 4847.442544107437, 4854.101991131617, 4814.66297359185, 4817.590504807095, 4821.325014497938, 4824.059308434857, 4826.420829500483, 5193.039287731744, 5245.449227831099, 5261.736913154327, 5272.393674727378, 5285.603579731497, 5679.744411501492, 5689.118186681071, 5694.914576281359, 5750.82747517571, 5766.106253530667, 5871.1193321001765, 5876.676782776945, 5879.794207202727, 5884.558658100659, 5891.410858914117, 5068.543831055186, 5341.786328546815, 5422.810201642924, 5477.890442191134, 5479.369872464677, 6013.428724271187, 6019.067044608093, 6027.005544085177, 6032.849178770478, 6036.577439579188, 5725.885482290331, 5729.512991395694, 5759.222504961776, 5774.191613174159, 5775.855603609859, 5448.591355648342, 5645.915311270334, 5720.2849643794525, 5732.598718089777, 5861.944849927054, 5681.744321505542, 5683.261176047087, 5683.829485115453, 5688.77244910199, 5712.80005199816, 5695.971520142372, 5715.228444159985, 5724.914126288026, 5733.455321744427, 5735.541156707453, 4261.936070958938, 4298.247806633826, 4364.1271745650365, 4370.541093185233, 4375.256206444912, 3877.3796192609047, 3908.687305015592, 3911.2959667259597, 3936.9212615747524, 3949.0324870406935, 5438.483344082306, 5482.972585137129, 5487.286652735119, 5492.505674489315, 5494.066008778437, 5432.972835135799, 5564.777408903598, 5609.747561359749, 5798.362180160179, 5861.0915308127305, 5329.813456529003, 5342.225377320345, 5349.705766182898, 5358.598105142052, 5368.8657783554945, 4825.469198388175, 4828.517148285214, 4831.0820944020525, 4832.44426890912, 4877.097736918681, 5758.827235182951, 5769.567282453832, 5826.76692932278, 5869.266341707286, 5877.382874798084, 5623.550115990629, 5632.5212356950115, 5643.887122257614, 5678.432156784289, 5700.315962084576, 5834.38738932406, 5840.591158618856, 5847.415258474119, 5848.327442344185, 5857.121431785266, 5370.731463426891, 5506.284183056177, 5539.833804985857, 5590.636608620427, 5631.183478395692, 5741.167530708108, 5786.826395208151, 5791.855203619774, 5797.0, 5838.474537291664, 5611.494965453129, 5617.634853734494, 5622.522085622604, 5638.830835074954, 5646.774129034792, 5379.946200537945, 5399.271098401822, 5399.865003374947, 5541.362743284574, 5617.662940223599, 5444.8094316698725, 5464.3442786865835, 5468.425815289496, 5470.234167216513, 5514.972425137848, 5463.699496527729, 5468.7539060741565, 5500.339959204921, 5512.586556008396, 5515.145152501369, 5334.253204551288, 5396.028714831368, 5397.325334333208, 5458.0, 5537.031019571639], "value": 5260.722766220818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7476572456708, 613.3345320327445, 635.9459445947093, 637.4486069549838, 651.3584119642148, 31685.524717129232, 45713.54286457135, 46827.76586117064, 46833.99999999991, 46849.29726054112, 47093.764531177294, 47348.76325618367, 47375.0, 47405.762971185184, 47448.52551474484, 8088.393370497207, 8982.86525702115, 9133.862992055092, 9142.451452912814, 10683.946580267087, 10489.213309001818, 10891.509882055287, 10898.0, 10904.182186336056, 10905.781884362308, 10930.726731831688, 11046.889531104707, 11050.502727377247, 11053.557857685722, 11060.336379817236, 10799.2440529163, 10864.0, 10916.235863489559, 10923.180761442924, 10933.343999360064, 10759.83860242097, 10781.83827242584, 10838.891611083945, 10862.78274434507, 10867.565297388095, 43651.0, 43781.78109109466, 44001.77999110016, 44048.0, 44056.559434405564, 3535.0985498697924, 3682.171511409938, 3901.726879118463, 3907.98046009771, 4174.749515029108, 33329.50005749916, 33806.49290260648, 34087.65912340894, 34128.82935585331, 35145.29709405823, 4298.78506074695, 4455.17579247837, 4461.553844615545, 4567.703099298535, 4582.564656357641, 360225.0, 361060.19469902746, 361924.0, 362342.0, 362603.0, 59514.404855951754, 59800.0, 59868.10197847036, 59875.401245986985, 60008.39991600028, 62379.37620623827, 62440.68779656073, 62457.68771156206, 62529.374706253264, 62552.68723656353, 14502.1298722077, 14724.779128313085, 14749.115053096848, 14752.926235368968, 14765.261736913111, 10608.257421980541, 11254.15593830466, 11261.66215013551, 11335.263207891461, 11541.36522491271, 16755.497335079966, 16795.0, 16832.495025149266, 16868.32526698943, 17018.744718829228, 5931.9703401483575, 5953.136795164677, 5979.701014949235, 6039.909401358983, 6152.507799376039, 950.4629884115452, 1037.4916291017498, 1101.9614313499148, 1131.3212072756444, 1169.736809217936, 32774.8361258197, 33505.329893402486, 33570.0, 33862.83068584641, 34223.14442138966, 1077.7952189084049, 1090.487470888681, 1137.6587023892798, 1179.8643156037165, 1189.6668932698858, 16613.50159495217, 17694.017935747564, 17811.46565603034, 17813.287468501374, 17915.0, 551760.0, 875897.0, 888999.0, 894126.0, 895473.0, 62260.0, 63018.0, 63126.36873631205, 63129.0, 63191.6840415795, 1220.6948262934266, 1300.1613958996206, 1330.7405056013984, 1332.247280286635, 1373.0525937103366, 32334.83832580822, 32747.181320467178, 35206.64793352034, 35434.822825885705, 35728.64271357357, 55703.0, 56591.71704141453, 56602.0, 56732.71633641805, 56843.715781420826, 557852.0, 562312.0, 565082.0, 565738.0, 566346.3365366294, 36501.904942851754, 37248.44127338038, 47046.76476617595, 47207.29189062236, 47982.76008619935, 50149.74925125351, 51137.48862511327, 51282.48717512777, 51319.23021154611, 55474.167887480915, 42547.36178957256, 42945.785271073444, 44639.77680111579, 47268.7636561815, 47899.5210047909, 44672.77663611791, 45495.31757023581, 45571.316430254235, 46438.76780616075, 47328.0, 45615.0, 46395.304070438295, 47102.528974709814, 47168.0, 47202.05595888132, 38490.23019539537, 40393.39409908795, 41451.37822932598, 41575.75272741823, 42358.78820606, 30881.536776947913, 31060.378792424475, 31071.378572427973, 31192.0, 31745.8412707935], "value": 21761.48218856466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.96571308582224, 389.2802672670491, 394.75525174391873, 398.84843759371444, 414.316377976339, 14476.5657030289, 18743.812561874376, 19056.0, 20651.07070181842, 20685.482862928435, 19157.616847663074, 19227.173418525254, 19467.610647787034, 20476.69284960727, 20584.8970755146, 5785.913211301823, 5960.612560183596, 5974.3428222895445, 5986.401359864, 6009.909851352233, 4265.8080386382535, 5836.328822185461, 5929.199558059671, 6385.808425747235, 6716.361945615183, 6660.333966603349, 6682.164729408824, 6729.899051514231, 6732.293109223535, 6740.932590674104, 6335.239771227436, 6530.183727034121, 6540.967295163494, 6549.34506549346, 6561.40947314744, 5213.4004589472315, 5476.945230547723, 5758.078707406837, 5766.336871259817, 5770.7691692332255, 14172.858271417257, 14202.289885505683, 14292.857071429256, 14410.207438590873, 14453.060551064253, 2194.9341519754435, 2277.248507992375, 2293.9770602294097, 2357.9882100589557, 2365.66880636711, 10217.846732299022, 10788.352698838095, 10927.508262128144, 11847.0, 15501.22493875313, 1899.477643647994, 1993.431871916497, 2014.869033512817, 2035.7557093148916, 2084.5830833833293, 76963.0, 79538.0, 81995.5900220501, 84825.99999999939, 85987.14012859853, 10819.188560857967, 10987.945060274647, 11025.503852326665, 11357.772844543228, 11412.0, 15358.692826143415, 15539.611509712347, 16011.919940400223, 16027.599310017344, 16052.75920861188, 7841.84349303946, 7932.977090841799, 7952.403569732293, 7969.481983671159, 8082.959585202037, 7339.559626422431, 7364.9746319761425, 7375.704971801175, 7497.587632680255, 7552.533138565111, 4798.2082956311815, 4803.159447096814, 4828.95171048285, 5004.024215277986, 5006.872079366255, 1933.5262860599244, 1960.8235258826774, 1973.2832435780963, 1992.571597106629, 2014.8488863335308, 909.286210324905, 1054.272551939175, 1064.526285802826, 1075.0539525217757, 1089.1123734156638, 20061.498462538555, 20850.270240541813, 20925.26761563338, 20956.851777866315, 21084.578308433745, 957.5738796235747, 958.6932181701928, 961.990380096204, 977.4135518688872, 981.7335637028153, 11102.555897764161, 11330.94334528322, 11507.309561426342, 11525.769484610428, 11530.94234528822, 418001.0, 516097.0, 529505.0, 530074.0, 531968.0, 57691.42308576944, 75983.62008189924, 78243.0, 87957.56021219853, 90044.09955900357, 929.2705226397246, 935.3452583191793, 1012.448215722433, 1014.7868947521104, 1041.1774697988656, 17982.730259045864, 18301.54246143857, 18700.78444901077, 18822.905885470485, 19041.809581904003, 43189.13621727611, 43285.7757026164, 43384.0, 44451.11097778091, 45543.77228113838, 61224.0, 61444.0, 61652.0, 62473.0, 63053.0, 8224.835503289782, 8495.192956669107, 8543.10297418787, 8553.700620478503, 8660.956695216484, 8762.430442021248, 12157.635270941886, 12701.618951431472, 13089.0, 13158.407871645608, 11190.552377905118, 11423.771524569296, 11626.88373116258, 11650.067994560584, 12010.39948002579, 10800.945995269973, 11200.831987520356, 11203.383813890314, 11313.7737245253, 11334.716632084264, 6307.810765677037, 8891.73324800257, 11196.328220306808, 11358.375289359165, 11915.463804128662, 8213.178682131978, 8227.341812654853, 8459.957700211706, 8478.321734261368, 8507.447015943944, 10885.673429797118, 11126.720427150658, 11203.775924481628, 11204.327740335606, 11412.429378530875], "value": 9178.772823508929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.805761222235, 1511.4407669162408, 1623.4642567952576, 1718.1752758675843, 1787.6603445345393, 8169.0, 8704.477731336125, 8706.782330441742, 8714.389992700506, 8716.259117974972, 7078.85842283154, 7251.528650637718, 7270.672819723112, 7477.25227477252, 8476.872846907301, 2310.1683393978196, 2384.129792625688, 2392.1627430399394, 2402.315340128064, 2405.2062819269686, 2389.2712722619594, 2412.16780210827, 2424.8423852449623, 2430.0765709030543, 2439.5486834935505, 2390.8087353011715, 2411.3730430088126, 2415.4323733922515, 2415.7342692303832, 2419.443527988564, 2355.2698663414394, 2357.03361621736, 2359.1860808021206, 2360.9409764755846, 2368.952620947571, 2315.178111770331, 2349.2247558305717, 2350.2361732437025, 2351.870647114408, 2362.7164740231283, 9002.369834111614, 9002.549872506414, 9035.32235082365, 9044.321675874337, 9088.50013249271, 5216.087184742692, 5280.762365693553, 5319.973400132974, 5346.492083252085, 5396.43337449566, 3377.3583019226267, 3484.6515348465205, 3656.597774244831, 3656.744027918047, 3658.432942893856, 1196.4316949449028, 1201.1231800785476, 1209.0931801149138, 1212.6847019774834, 1234.9135560510767, 12340.629781106582, 12365.93817030918, 12367.257964522067, 12400.317982510958, 12416.317102559356, 4769.165396055676, 4788.850675837773, 4808.134535783593, 4903.043906438282, 4929.802807887644, 10453.163746900382, 10463.790724185474, 10467.528961196613, 10467.633632822966, 10468.371897686164, 5314.813981510629, 5341.7062061586985, 5351.946480535223, 5355.0, 5357.651752636066, 4805.27920811874, 4871.853844384674, 4879.463259041502, 4879.902401951941, 4919.335889654851, 3881.204353107606, 3884.1454879926373, 3941.467901833273, 3981.044549308145, 4000.6799456043445, 1184.6209213051914, 1185.5554167187304, 1186.5313201285444, 1189.3280296632374, 1202.4348556178581, 862.0, 962.7785609309758, 964.8504481805331, 986.1026465915982, 991.5984026469291, 6011.0, 6058.454739073504, 6161.568690191643, 6225.159603453566, 6331.746730130835, 471.89382388962207, 474.7863461442296, 476.6663335665048, 483.37161689803116, 484.8957474143076, 4078.632923036941, 4116.9794151029655, 4216.9789151054665, 4240.194363071068, 4297.720648157922, 10522.316049456915, 10830.620928267474, 10917.39954302505, 10920.781584368428, 10941.781164376827, 10233.99999999985, 10818.67543973682, 10832.566697332019, 10842.891571084347, 10844.728881778019, 7995.840083198304, 8169.060558035783, 8359.498430094092, 8362.8327433451, 8379.036410812712, 5664.150377443417, 5902.940970590411, 5963.91054134197, 5994.400559943971, 6031.095335699505, 9960.688058748496, 9995.250356223167, 10134.087932086148, 10165.034321739422, 10177.491125443847, 10241.129503991946, 10254.58981640726, 10320.329178603668, 10334.793304133726, 10437.58249670035, 7131.964340178266, 8142.3486121111355, 8358.414910956419, 8459.154084591737, 8644.870326944974, 8379.622916968628, 8686.78283042929, 8736.563171841255, 8754.91245087541, 8757.255633271243, 7542.132654744774, 7649.196834332315, 7663.923360766321, 7895.881561776463, 7944.364450843803, 7555.546667199986, 7662.655180516778, 7685.154632990255, 7873.724419645285, 7950.165232650488, 7060.435165186876, 7101.964490177516, 7165.713371465083, 7185.820354491179, 7263.0921134858145, 5085.7457127144235, 5203.73981300941, 5225.268462415189, 5246.580273578181, 5358.651687640291, 5119.590432765444, 5198.350206224222, 5201.193814958688, 5275.841724748264, 5355.70543620089], "value": 4601.374555787211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.30635665103284, 332.0817938400323, 342.4418198336711, 344.1825664047887, 346.2244572158363, 5276.788928442863, 5313.495217954298, 5323.60072994525, 5344.198370244465, 5350.180938480916, 4991.475895031024, 5065.088284108859, 5205.635605507616, 5227.869303267411, 5242.344706911636, 4171.207470580595, 4182.8745137645765, 4215.747055176684, 4234.9364759528635, 4239.4986957694955, 4188.4136220929095, 4210.3894935234375, 4223.429836972015, 4230.111676547913, 4243.469566304212, 3941.0935484838506, 4024.2756303865294, 4124.237016152007, 4138.6482149017365, 4170.47869016373, 4132.214879172978, 4143.150654115899, 4145.1916876209, 4153.252414565377, 4155.833766649331, 3696.244283965122, 3703.925921481582, 3708.9258214835822, 3720.981395093007, 3721.0, 5039.168537191359, 5047.343845300087, 5069.543741063322, 5100.118433085295, 5185.714785686786, 4685.812567497296, 4697.765111744433, 4707.270373092142, 4711.693739906929, 4770.044281844427, 5402.405735369106, 5451.781928722847, 5459.836204913859, 5463.344398672145, 5494.780208791643, 3879.8836034919, 4013.6789056875673, 4041.2725709372303, 4049.7975101245115, 4052.2098190852794, 5641.661500309953, 5687.772489100431, 5689.914651280193, 5709.0, 5715.714214289269, 4148.668106551469, 4151.6886233532605, 4153.605407486284, 4157.875263742093, 4162.231051802972, 3961.742486738353, 4123.278426275389, 4125.876223713293, 4225.514065882401, 4234.661227101825, 4682.742449165328, 4694.413198350207, 4698.88252793676, 4714.481407045222, 4726.976365118221, 5531.9723401382735, 5539.307586551681, 5544.61187716856, 5557.277553918046, 5578.832635020955, 1344.5159742492694, 1353.3098119958893, 1399.7200559888063, 1408.4929425406845, 1423.2172305232289, 920.4293338130402, 948.9240860731124, 959.6449313753956, 961.8268711631973, 964.7313782376153, 5283.973580132075, 5292.206169074592, 5303.416624171338, 5310.203469479609, 5340.198970154508, 5571.275734154615, 5595.8601034973635, 5599.32808063035, 5611.9438805612235, 5617.129344951539, 5190.8183213587345, 5397.78408863641, 5435.695433096029, 5436.809711660073, 5459.945400546023, 3001.9099427017222, 3012.3071693510615, 3016.3816417634334, 3032.9393412132076, 3036.9848150759103, 5692.9146062809095, 5848.883022339614, 5849.5027922626205, 5853.912191317134, 5882.147123656035, 5718.428157184248, 5740.311162660508, 5747.85630359236, 5764.279465066867, 5774.82675519735, 5819.970900145472, 5821.825345239649, 5838.182654428383, 5859.296884373903, 5887.499562537232, 5426.294581704511, 5624.634398764068, 5679.148127780701, 5691.3170419549915, 5702.6293290935955, 5543.170753651205, 5580.441955804387, 5585.301837270341, 5587.525060369914, 5612.438756124355, 5784.917429725211, 5842.211301474246, 5865.296164460292, 5866.882662346815, 5938.5259623120955, 4032.939505907355, 4048.473698419187, 4053.0, 4059.5737447568763, 4070.816813243352, 5677.801276955287, 5684.431556844283, 5699.2590963174525, 5713.22871412354, 5724.484796368347, 5251.52736253739, 5448.863778405572, 5511.614187007031, 5539.806106786243, 5570.192322113352, 5466.0, 5471.835844924659, 5502.422245664147, 5509.972450137884, 5521.5306698931045, 5210.525000624673, 5366.497380733401, 5389.380221274603, 5528.253685752372, 5528.253685752372, 5053.84838454847, 5183.896322073462, 5551.583631227755, 5557.499825015768, 5587.7485513152815, 5413.56691464674, 5419.376771671308, 5426.593005524523, 5440.945590544044, 5461.15352120422], "value": 4228.61765178153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.1990969211405, 813.4549851599428, 813.6663967773212, 830.2610676497922, 832.4173078844808, 15415.15216663083, 16054.759178612301, 16635.50093497194, 16780.41268555599, 16781.83218167818, 14721.779173312381, 14835.851641483581, 14844.33200505977, 14914.17972011539, 14918.328675209614, 808.9514629122272, 831.9168083191693, 835.2357592802579, 835.7826964989085, 835.9164083591653, 679.2426444514356, 802.2018091998469, 824.1346586084617, 831.4595512916592, 833.3374966901298, 859.5702148925537, 860.0324634785866, 861.6294993152973, 861.6811779641541, 862.2326129744501, 848.4061157189992, 856.4903882190087, 857.4555157475017, 857.8370109679141, 858.6393714639867, 508.9109405853961, 605.1135087097423, 617.3086143519287, 619.6313193649771, 621.2389822467486, 15522.223888805627, 15559.688806223925, 15562.922185389114, 15564.221788910509, 15609.375624974988, 13966.0, 14276.643083922881, 14619.269036548236, 14723.0, 14804.333804978802, 11918.523259069627, 12109.0, 12169.269843809312, 12238.632841014783, 12273.509059637603, 4419.508932359651, 4481.731096134243, 4545.818167273305, 4577.899080160287, 4674.485806561275, 77142.22857771406, 78672.0, 80153.0, 81804.59097704533, 83743.58128209382, 11680.123990700562, 11751.706207344885, 11791.35147566875, 11936.0, 11939.46272417726, 22195.0, 22324.55350892973, 22326.665100023514, 22326.77673223247, 22368.0, 8563.95718021406, 8852.513111778786, 8997.055309192572, 9031.63873445068, 9209.63161473547, 4635.564758215542, 4663.323818046364, 4684.859454216379, 4780.402449693788, 4892.315075889378, 3415.777974431654, 3503.3343664703625, 3506.4214404622953, 3507.596626387998, 3516.5780106387397, 597.4533302028682, 603.6317846113867, 649.3701109923367, 678.2098854834162, 679.1578442731077, 668.669008840627, 677.552815142004, 687.9105716256954, 698.9266127056586, 703.6587255181233, 9215.63137474507, 9869.21046316293, 9892.35699679533, 10358.601588785568, 10837.674869753762, 640.6124294801671, 728.3408515293668, 731.5208538407352, 775.9418043646749, 782.2451334462271, 4902.338184345068, 5074.873128171826, 5130.48695130484, 5180.248863914711, 5191.9480805192225, 101292.0, 129217.0, 131288.3435582816, 132790.33604832107, 132926.0, 108548.4572577132, 110739.89260107456, 114373.4281328588, 114473.4276328613, 116585.0, 99468.5026574877, 101416.0, 102477.0, 102649.30130240113, 105605.0, 9495.14543691071, 9750.902490975282, 9770.706878793648, 9809.656662016796, 9823.410595364301, 57010.0, 57072.0, 57222.42777572171, 57846.0, 59247.0, 81371.0, 85388.57305713432, 85558.57220713857, 87396.0, 88399.0, 12099.637010889688, 12757.808632870328, 12774.552890648783, 13185.934070329587, 13391.799123013358, 13830.239336836168, 14070.085444446488, 14368.56597127461, 14554.27228638585, 14705.264736763333, 13724.65688357759, 13771.793423098861, 13936.930315348358, 14183.432662693376, 14448.171234623043, 12146.878531214576, 12309.871942611091, 12465.439055242354, 12818.743625127632, 13721.931390342985, 13165.407556659782, 13528.86471135276, 14189.361478733688, 14566.563003109924, 14608.561743147722, 11825.940870295593, 11904.464299106388, 11995.220310679779, 12004.819927701266, 12404.317762523147, 10964.287321324407, 12279.938600306941, 12346.320952347707, 12775.041871859461, 12803.10378273512], "value": 7861.453692841741, "unit": "score"}], "name": "dromaeo_css", "value": 7373.822677312752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 120.0, 174.0, 125.0, 125.0, 149.0, 116.0, 159.0, 120.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 77.0, 75.0, 76.0, 76.0, 120.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 85.0, 84.0, 84.0, 125.0, 84.0, 84.0, 120.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 84.0, 76.0, 75.0, 75.0, 85.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 119.0, 135.0, 124.0, 127.0, 121.0, 120.0, 166.0, 127.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 156.0, 157.0, 157.0, 156.0, 157.0, 160.0, 157.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 64.0, 63.0, 63.0, 61.0, 61.0, 62.0, 63.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1481.5, "alertThreshold": 2.0}]} 19:24:52 INFO - Return code: 0 19:24:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:52 INFO - # TBPL SUCCESS # 19:24:52 INFO - Running post-action listener: _resource_record_post_action 19:24:52 INFO - [mozharness: 2016-07-26 02:24:52.304239Z] Finished run-tests step (success) 19:24:52 INFO - Running post-run listener: _resource_record_post_run 19:24:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 163840; Write bytes: 303423488; Read time: 300; Write time: 208436 19:24:52 INFO - TinderboxPrint: CPU usage
12.9% 19:24:52 INFO - TinderboxPrint: I/O read bytes / time
163,840 / 300 19:24:52 INFO - TinderboxPrint: I/O write bytes / time
303,423,488 / 208,436 19:24:52 INFO - TinderboxPrint: CPU idle
8,280.9 (87.0%) 19:24:52 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 19:24:52 INFO - TinderboxPrint: Swap in / out
0 / 0 19:24:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 11378688; Read time: 0; Write time: 2184 19:24:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 159744; Write bytes: 292044800; Read time: 288; Write time: 206252 19:24:52 INFO - Running post-run listener: _upload_blobber_files 19:24:52 INFO - Blob upload gear active. 19:24:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:52 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:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:24:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:54 INFO - (blobuploader) - INFO - Done attempting. 19:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:54 INFO - (blobuploader) - INFO - Done attempting. 19:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:01 INFO - (blobuploader) - INFO - Done attempting. 19:25:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:01 INFO - Return code: 0 19:25:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04e3e689fc0f6854d96b077158a09b560d859f2e77e723222ccbfd6b5fac255add09076035d4b3ff5e76450f0958fc060be0c970b3cc659ff1c1719fbfb489e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84b32ceeaebe1ef5d77e13ffdbca6e285e121fdf234677939b893ff3f58d2065cfa5f39998385ce413f854cb97bb73176a48efcd4c3b464a3c8fe7654336de15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfc0ffe1eca1ed6b8c5970d3a47383ee7c5a4bf1d9043c5c40fe3f18f37b91707a80cd0286063629af686e9f1b6c20589156d4495379fc99bb57608de8bfb90"} 19:25:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:01 INFO - Contents: 19:25:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04e3e689fc0f6854d96b077158a09b560d859f2e77e723222ccbfd6b5fac255add09076035d4b3ff5e76450f0958fc060be0c970b3cc659ff1c1719fbfb489e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84b32ceeaebe1ef5d77e13ffdbca6e285e121fdf234677939b893ff3f58d2065cfa5f39998385ce413f854cb97bb73176a48efcd4c3b464a3c8fe7654336de15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfc0ffe1eca1ed6b8c5970d3a47383ee7c5a4bf1d9043c5c40fe3f18f37b91707a80cd0286063629af686e9f1b6c20589156d4495379fc99bb57608de8bfb90"} 19:25:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:01 INFO - Copying logs to upload dir... 19:25:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.764861 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-25 19:25:01.184535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 19:25:01.187779) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04e3e689fc0f6854d96b077158a09b560d859f2e77e723222ccbfd6b5fac255add09076035d4b3ff5e76450f0958fc060be0c970b3cc659ff1c1719fbfb489e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84b32ceeaebe1ef5d77e13ffdbca6e285e121fdf234677939b893ff3f58d2065cfa5f39998385ce413f854cb97bb73176a48efcd4c3b464a3c8fe7654336de15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfc0ffe1eca1ed6b8c5970d3a47383ee7c5a4bf1d9043c5c40fe3f18f37b91707a80cd0286063629af686e9f1b6c20589156d4495379fc99bb57608de8bfb90"} build_url:https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/YWKb-j5PQ3mpbeV1oEfQdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04e3e689fc0f6854d96b077158a09b560d859f2e77e723222ccbfd6b5fac255add09076035d4b3ff5e76450f0958fc060be0c970b3cc659ff1c1719fbfb489e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84b32ceeaebe1ef5d77e13ffdbca6e285e121fdf234677939b893ff3f58d2065cfa5f39998385ce413f854cb97bb73176a48efcd4c3b464a3c8fe7654336de15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfc0ffe1eca1ed6b8c5970d3a47383ee7c5a4bf1d9043c5c40fe3f18f37b91707a80cd0286063629af686e9f1b6c20589156d4495379fc99bb57608de8bfb90"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 19:25:01.213191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:25:01.213544) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469498447.717602-1808107345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 19:25:01.298638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 19:25:01.298999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 19:25:01.299387) ========= ========= Total master_lag: 0.17 =========