builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1469893911.86 results: success (0) buildid: 20160730072526 builduid: e59f4307007f4182845bc3b69d8f9c34 revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:51.865332) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:51.866125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:51.866580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:51.899871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:51.900157) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 08:51:52-- 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% 46.3M=0s 2016-07-30 08:51:52 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:52.039890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:52.040404) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019369 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:52.091987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-30 08:51:52.092724) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b500a963fd364f41d32422d5249233a124f85e7 --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 5b500a963fd364f41d32422d5249233a124f85e7 --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=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 08:51:52,392 truncating revision to first 12 chars 2016-07-30 08:51:52,392 Setting DEBUG logging. 2016-07-30 08:51:52,392 attempt 1/10 2016-07-30 08:51:52,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b500a963fd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 08:51:54,172 unpacking tar archive at: fx-team-5b500a963fd3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.122107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-30 08:51:54.230807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:54.231430) ========= script_repo_revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:54.231936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:54.232437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:51:54.244392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-30 08:51:54.244839) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:51:54 INFO - MultiFileLogger online at 20160730 08:51:54 in /builds/slave/test 08:51:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:51:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:54 INFO - {'append_to_log': False, 08:51:54 INFO - 'base_work_dir': '/builds/slave/test', 08:51:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:51:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:54 INFO - 'branch': 'Fx-Team-Non-PGO', 08:51:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:54 INFO - 'config_files': ('talos/linux_config.py',), 08:51:54 INFO - 'default_actions': ('clobber', 08:51:54 INFO - 'read-buildbot-config', 08:51:54 INFO - 'download-and-extract', 08:51:54 INFO - 'populate-webroot', 08:51:54 INFO - 'create-virtualenv', 08:51:54 INFO - 'install', 08:51:54 INFO - 'run-tests'), 08:51:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:54 INFO - 'download_minidump_stackwalk': True, 08:51:54 INFO - 'download_symbols': 'ondemand', 08:51:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:54 INFO - 'installer_path': 'installer.exe', 08:51:54 INFO - 'log_level': 'info', 08:51:54 INFO - 'log_name': 'talos', 08:51:54 INFO - 'log_to_console': True, 08:51:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:51:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:51:54 INFO - 'opt_config_files': (), 08:51:54 INFO - 'pip_index': False, 08:51:54 INFO - 'sps_profile': False, 08:51:54 INFO - 'sps_profile_interval': 0, 08:51:54 INFO - 'suite': 'dromaeojs', 08:51:54 INFO - 'system_bits': '32', 08:51:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:54 INFO - 'title': 'talos-linux64-ix-040', 08:51:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:54 INFO - 'use_talos_json': True, 08:51:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:54 INFO - 'work_dir': 'build'} 08:51:54 INFO - [mozharness: 2016-07-30 15:51:54.639496Z] Running clobber step. 08:51:54 INFO - Running pre-action listener: _resource_record_pre_action 08:51:54 INFO - Running main action method: clobber 08:51:54 INFO - rmtree: /builds/slave/test/build 08:51:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:55 INFO - Running post-action listener: _resource_record_post_action 08:51:55 INFO - [mozharness: 2016-07-30 15:51:55.104915Z] Finished clobber step (success) 08:51:55 INFO - [mozharness: 2016-07-30 15:51:55.105016Z] Running read-buildbot-config step. 08:51:55 INFO - Running pre-action listener: _resource_record_pre_action 08:51:55 INFO - Running main action method: read_buildbot_config 08:51:55 INFO - Using buildbot properties: 08:51:55 INFO - { 08:51:55 INFO - "project": "", 08:51:55 INFO - "product": "firefox", 08:51:55 INFO - "script_repo_revision": "production", 08:51:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:51:55 INFO - "repository": "", 08:51:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:51:55 INFO - "buildid": "20160730072526", 08:51:55 INFO - "pgo_build": "False", 08:51:55 INFO - "basedir": "/builds/slave/test", 08:51:55 INFO - "buildnumber": 2052, 08:51:55 INFO - "slavename": "talos-linux64-ix-040", 08:51:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:51:55 INFO - "platform": "ubuntu64_hw", 08:51:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:51:55 INFO - "branch": "fx-team", 08:51:55 INFO - "repo_path": "integration/fx-team", 08:51:55 INFO - "revision": "5b500a963fd364f41d32422d5249233a124f85e7", 08:51:55 INFO - "stage_platform": "linux64", 08:51:55 INFO - "builduid": "e59f4307007f4182845bc3b69d8f9c34", 08:51:55 INFO - "slavebuilddir": "test" 08:51:55 INFO - } 08:51:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:51:55 INFO - Running post-action listener: _resource_record_post_action 08:51:55 INFO - [mozharness: 2016-07-30 15:51:55.107478Z] Finished read-buildbot-config step (success) 08:51:55 INFO - [mozharness: 2016-07-30 15:51:55.107568Z] Running download-and-extract step. 08:51:55 INFO - Running pre-action listener: _resource_record_pre_action 08:51:55 INFO - Running main action method: download_and_extract 08:51:55 INFO - mkdir: /builds/slave/test/build/tests 08:51: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')]} 08:51:55 INFO - https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:02 INFO - Downloaded 1361 bytes. 08:52:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:52:02 INFO - Using the following test package requirements: 08:52:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:52:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:52:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:52:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'jsshell-linux-x86_64.zip'], 08:52:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:52:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:52:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:52:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:52:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:52:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:52:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:52:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:02 INFO - https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:52:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:52:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:52:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:03 INFO - Downloaded 20232077 bytes. 08:52:03 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'] 08:52:03 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 08:52:04 INFO - Return code: 0 08:52:04 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 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:04 INFO - https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:07 INFO - Downloaded 20232077 bytes. 08:52:07 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'] 08:52:07 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 08:52:08 INFO - Return code: 0 08:52:08 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')]} 08:52:08 INFO - https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:52:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:52:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:52:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:09 INFO - Downloaded 14413723 bytes. 08:52:09 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'] 08:52:09 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 08:52:09 INFO - Return code: 0 08:52:09 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')]} 08:52:09 INFO - https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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 08:52:11 INFO - Downloaded 55599590 bytes. 08:52:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:52:11 INFO - mkdir: /builds/slave/test/properties 08:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:11 INFO - Contents: 08:52:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:52:12 INFO - Running post-action listener: _resource_record_post_action 08:52:12 INFO - Running post-action listener: set_extra_try_arguments 08:52:12 INFO - [mozharness: 2016-07-30 15:52:12.370640Z] Finished download-and-extract step (success) 08:52:12 INFO - [mozharness: 2016-07-30 15:52:12.370964Z] Running populate-webroot step. 08:52:12 INFO - Running pre-action listener: _resource_record_pre_action 08:52:12 INFO - Running main action method: populate_webroot 08:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:12 INFO - '--tppagecycles', 08:52:12 INFO - '7'], 08:52:12 INFO - 'tests': ['tsvgm']}}, 08:52:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['damp', 'tps']}, 08:52:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'tests': ['damp', 'tps']}, 08:52:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['dromaeo_dom']}, 08:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['basic_compositor_video']}, 08:52:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:52:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['a11yr', 08:52:12 INFO - 'ts_paint', 08:52:12 INFO - 'tpaint', 08:52:12 INFO - 'sessionrestore', 08:52:12 INFO - 'sessionrestore_no_auto_restore', 08:52:12 INFO - 'tabpaint']}, 08:52:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['tsvgx', 08:52:12 INFO - 'tsvgr_opacity', 08:52:12 INFO - 'tart', 08:52:12 INFO - 'tscrollx', 08:52:12 INFO - 'cart']}, 08:52:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:12 INFO - 'tsvgr_opacity', 08:52:12 INFO - 'tart', 08:52:12 INFO - 'tscrollx', 08:52:12 INFO - 'cart']}, 08:52:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'talos_options': ['--disable-e10s'], 08:52:12 INFO - 'tests': ['tp5o']}, 08:52:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'tests': ['tp5o']}, 08:52:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'talos_options': ['--disable-e10s', 08:52:12 INFO - '--xperf_path', 08:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:12 INFO - 'tests': ['tp5n']}, 08:52:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:12 INFO - 'talos_options': ['--xperf_path', 08:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:12 INFO - 'tests': ['tp5n']}}, 08:52:12 INFO - 'talos.zip': {'path': '', 08:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:12 INFO - Running post-action listener: _resource_record_post_action 08:52:12 INFO - [mozharness: 2016-07-30 15:52:12.393159Z] Finished populate-webroot step (success) 08:52:12 INFO - [mozharness: 2016-07-30 15:52:12.393248Z] Running create-virtualenv step. 08:52:12 INFO - Running pre-action listener: _resource_record_pre_action 08:52:12 INFO - Running main action method: create_virtualenv 08:52:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:12 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 08:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:12 INFO - Using real prefix '/usr' 08:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:15 INFO - Installing pip.................done. 08:52:15 INFO - Return code: 0 08:52:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:15 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 08:52:15 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 08:52:15 INFO - Using env: {'DISPLAY': ':0', 08:52:15 INFO - 'HOME': '/home/cltbld', 08:52:15 INFO - 'LANG': 'en_US.UTF-8', 08:52:15 INFO - 'LANGUAGE': 'en_US:en', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MAIL': '/var/mail/cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SHLVL': '1', 08:52:15 INFO - 'TERM': 'linux', 08:52:15 INFO - 'TMOUT': '86400', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 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 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:15 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 08:52:15 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 08:52:15 INFO - Using env: {'DISPLAY': ':0', 08:52:15 INFO - 'HOME': '/home/cltbld', 08:52:15 INFO - 'LANG': 'en_US.UTF-8', 08:52:15 INFO - 'LANGUAGE': 'en_US:en', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MAIL': '/var/mail/cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SHLVL': '1', 08:52:15 INFO - 'TERM': 'linux', 08:52:15 INFO - 'TMOUT': '86400', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Downloading/unpacking psutil>=3.1.1 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:17 INFO - Installing collected packages: psutil 08:52:17 INFO - Running setup.py install for psutil 08:52:17 INFO - building 'psutil._psutil_linux' extension 08:52:17 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 08:52:17 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 08:52:17 INFO - building 'psutil._psutil_posix' extension 08:52:17 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 08:52:17 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 08:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:17 INFO - Successfully installed psutil 08:52:17 INFO - Cleaning up... 08:52:17 INFO - Return code: 0 08:52:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:17 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:17 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 08:52:17 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 08:52:17 INFO - Using env: {'DISPLAY': ':0', 08:52:17 INFO - 'HOME': '/home/cltbld', 08:52:17 INFO - 'LANG': 'en_US.UTF-8', 08:52:17 INFO - 'LANGUAGE': 'en_US:en', 08:52:17 INFO - 'LOGNAME': 'cltbld', 08:52:17 INFO - 'MAIL': '/var/mail/cltbld', 08:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:17 INFO - 'MOZ_NO_REMOTE': '1', 08:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:17 INFO - 'NO_EM_RESTART': '1', 08:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:17 INFO - 'PWD': '/builds/slave/test', 08:52:17 INFO - 'SHELL': '/bin/bash', 08:52:17 INFO - 'SHLVL': '1', 08:52:17 INFO - 'TERM': 'linux', 08:52:17 INFO - 'TMOUT': '86400', 08:52:17 INFO - 'USER': 'cltbld', 08:52:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:17 INFO - '_': '/tools/buildbot/bin/python'} 08:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:18 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 08:52:18 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 08:52:18 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 08:52:18 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 08:52:18 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 08:52:18 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 08:52:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:20 INFO - Installing collected packages: mozsystemmonitor 08:52:20 INFO - Running setup.py install for mozsystemmonitor 08:52:20 INFO - Successfully installed mozsystemmonitor 08:52:20 INFO - Cleaning up... 08:52:20 INFO - Return code: 0 08:52:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:20 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:20 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 08:52:20 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 08:52:20 INFO - Using env: {'DISPLAY': ':0', 08:52:20 INFO - 'HOME': '/home/cltbld', 08:52:20 INFO - 'LANG': 'en_US.UTF-8', 08:52:20 INFO - 'LANGUAGE': 'en_US:en', 08:52:20 INFO - 'LOGNAME': 'cltbld', 08:52:20 INFO - 'MAIL': '/var/mail/cltbld', 08:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:20 INFO - 'MOZ_NO_REMOTE': '1', 08:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:20 INFO - 'NO_EM_RESTART': '1', 08:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:20 INFO - 'PWD': '/builds/slave/test', 08:52:20 INFO - 'SHELL': '/bin/bash', 08:52:20 INFO - 'SHLVL': '1', 08:52:20 INFO - 'TERM': 'linux', 08:52:20 INFO - 'TMOUT': '86400', 08:52:20 INFO - 'USER': 'cltbld', 08:52:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:20 INFO - '_': '/tools/buildbot/bin/python'} 08:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:22 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 08:52:22 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 08:52:22 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 08:52:22 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 08:52:22 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 08:52:22 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 08:52:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:22 INFO - warning: no files found matching '*.txt' 08:52:22 INFO - no previously-included directories found matching 'build' 08:52:22 INFO - no previously-included directories found matching 'dist' 08:52:22 INFO - no previously-included directories found matching '.git*' 08:52:22 INFO - Installing collected packages: jsonschema, functools32 08:52:22 INFO - Running setup.py install for functools32 08:52:22 INFO - warning: no files found matching '*.txt' 08:52:22 INFO - no previously-included directories found matching 'build' 08:52:22 INFO - no previously-included directories found matching 'dist' 08:52:22 INFO - no previously-included directories found matching '.git*' 08:52:22 INFO - Successfully installed jsonschema functools32 08:52:22 INFO - Cleaning up... 08:52:22 INFO - Return code: 0 08:52:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:22 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')]} 08:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:22 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')]} 08:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:22 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:22 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 08:52:22 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 08:52:22 INFO - Using env: {'DISPLAY': ':0', 08:52:22 INFO - 'HOME': '/home/cltbld', 08:52:22 INFO - 'LANG': 'en_US.UTF-8', 08:52:22 INFO - 'LANGUAGE': 'en_US:en', 08:52:22 INFO - 'LOGNAME': 'cltbld', 08:52:22 INFO - 'MAIL': '/var/mail/cltbld', 08:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:22 INFO - 'MOZ_NO_REMOTE': '1', 08:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:22 INFO - 'NO_EM_RESTART': '1', 08:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:22 INFO - 'PWD': '/builds/slave/test', 08:52:22 INFO - 'SHELL': '/bin/bash', 08:52:22 INFO - 'SHLVL': '1', 08:52:22 INFO - 'TERM': 'linux', 08:52:22 INFO - 'TMOUT': '86400', 08:52:22 INFO - 'USER': 'cltbld', 08:52:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:22 INFO - '_': '/tools/buildbot/bin/python'} 08:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:23 INFO - Cleaning up... 08:52:23 INFO - Return code: 0 08:52:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:23 INFO - Using env: {'DISPLAY': ':0', 08:52:23 INFO - 'HOME': '/home/cltbld', 08:52:23 INFO - 'LANG': 'en_US.UTF-8', 08:52:23 INFO - 'LANGUAGE': 'en_US:en', 08:52:23 INFO - 'LOGNAME': 'cltbld', 08:52:23 INFO - 'MAIL': '/var/mail/cltbld', 08:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:23 INFO - 'MOZ_NO_REMOTE': '1', 08:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:23 INFO - 'NO_EM_RESTART': '1', 08:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:23 INFO - 'PWD': '/builds/slave/test', 08:52:23 INFO - 'SHELL': '/bin/bash', 08:52:23 INFO - 'SHLVL': '1', 08:52:23 INFO - 'TERM': 'linux', 08:52:23 INFO - 'TMOUT': '86400', 08:52:23 INFO - 'USER': 'cltbld', 08:52:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:23 INFO - '_': '/tools/buildbot/bin/python'} 08:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 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 08:52:25 INFO - Downloading docopt-0.6.1.tar.gz 08:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:25 INFO - Running setup.py install for blobuploader 08:52:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:25 INFO - Running setup.py install for requests 08:52:26 INFO - Running setup.py install for docopt 08:52:26 INFO - Successfully installed blobuploader requests docopt 08:52:26 INFO - Cleaning up... 08:52:26 INFO - Return code: 0 08:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:26 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')]} 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 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')]} 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:26 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:26 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 08:52:26 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 08:52:26 INFO - Using env: {'DISPLAY': ':0', 08:52:26 INFO - 'HOME': '/home/cltbld', 08:52:26 INFO - 'LANG': 'en_US.UTF-8', 08:52:26 INFO - 'LANGUAGE': 'en_US:en', 08:52:26 INFO - 'LOGNAME': 'cltbld', 08:52:26 INFO - 'MAIL': '/var/mail/cltbld', 08:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:26 INFO - 'MOZ_NO_REMOTE': '1', 08:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:26 INFO - 'NO_EM_RESTART': '1', 08:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:26 INFO - 'PWD': '/builds/slave/test', 08:52:26 INFO - 'SHELL': '/bin/bash', 08:52:26 INFO - 'SHLVL': '1', 08:52:26 INFO - 'TERM': 'linux', 08:52:26 INFO - 'TMOUT': '86400', 08:52:26 INFO - 'USER': 'cltbld', 08:52:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:26 INFO - '_': '/tools/buildbot/bin/python'} 08:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:26 INFO - Running setup.py (path:/tmp/pip-AcUJJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:26 INFO - Running setup.py (path:/tmp/pip-iigPjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:26 INFO - Running setup.py (path:/tmp/pip-xmg0D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:26 INFO - Running setup.py (path:/tmp/pip-m7Usnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:27 INFO - Running setup.py (path:/tmp/pip-kB9v5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:27 INFO - Running setup.py (path:/tmp/pip-4mRqXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:27 INFO - Running setup.py (path:/tmp/pip-Eg3BU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:27 INFO - Running setup.py (path:/tmp/pip-f9ZGf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:27 INFO - Running setup.py (path:/tmp/pip-F3cONR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:27 INFO - Running setup.py (path:/tmp/pip-lvtFIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:27 INFO - Running setup.py (path:/tmp/pip-ztEvvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:27 INFO - Running setup.py (path:/tmp/pip-EJ2SG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:27 INFO - Running setup.py (path:/tmp/pip-MnbsLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:27 INFO - Running setup.py (path:/tmp/pip-mdh5pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:27 INFO - Running setup.py (path:/tmp/pip-0DUMo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:27 INFO - Running setup.py (path:/tmp/pip-HVQg7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:27 INFO - Running setup.py (path:/tmp/pip-KQJMqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:27 INFO - Running setup.py install for manifestparser 08:52:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for mozcrash 08:52:28 INFO - Running setup.py install for mozdebug 08:52:28 INFO - Running setup.py install for mozdevice 08:52:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for mozfile 08:52:28 INFO - Running setup.py install for mozhttpd 08:52:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for mozinfo 08:52:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for mozInstall 08:52:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for mozleak 08:52:28 INFO - Running setup.py install for mozlog 08:52:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:28 INFO - Running setup.py install for moznetwork 08:52:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozprocess 08:52:29 INFO - Running setup.py install for mozprofile 08:52:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozrunner 08:52:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozscreenshot 08:52:29 INFO - Running setup.py install for moztest 08:52:29 INFO - Running setup.py install for mozversion 08:52:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:29 INFO - Cleaning up... 08:52:29 INFO - Return code: 0 08:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:29 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')]} 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:29 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')]} 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:29 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:29 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 08:52:29 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 08:52:29 INFO - Using env: {'DISPLAY': ':0', 08:52:29 INFO - 'HOME': '/home/cltbld', 08:52:29 INFO - 'LANG': 'en_US.UTF-8', 08:52:29 INFO - 'LANGUAGE': 'en_US:en', 08:52:29 INFO - 'LOGNAME': 'cltbld', 08:52:29 INFO - 'MAIL': '/var/mail/cltbld', 08:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:29 INFO - 'MOZ_NO_REMOTE': '1', 08:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:29 INFO - 'NO_EM_RESTART': '1', 08:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:29 INFO - 'PWD': '/builds/slave/test', 08:52:29 INFO - 'SHELL': '/bin/bash', 08:52:29 INFO - 'SHLVL': '1', 08:52:29 INFO - 'TERM': 'linux', 08:52:29 INFO - 'TMOUT': '86400', 08:52:29 INFO - 'USER': 'cltbld', 08:52:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:29 INFO - '_': '/tools/buildbot/bin/python'} 08:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:29 INFO - Running setup.py (path:/tmp/pip-g4Wif0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:30 INFO - Running setup.py (path:/tmp/pip-EP5DIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:30 INFO - Running setup.py (path:/tmp/pip-mmCvTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:30 INFO - Running setup.py (path:/tmp/pip-eIc8k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:30 INFO - Running setup.py (path:/tmp/pip-zLNUNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:30 INFO - Running setup.py (path:/tmp/pip-TNcxoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:30 INFO - Running setup.py (path:/tmp/pip-ahzp8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:30 INFO - Running setup.py (path:/tmp/pip-E7k2O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:30 INFO - Running setup.py (path:/tmp/pip-b6Hatm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:30 INFO - Running setup.py (path:/tmp/pip-9UkaMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:30 INFO - Running setup.py (path:/tmp/pip-7_DVNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:30 INFO - Running setup.py (path:/tmp/pip-6lAV_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:30 INFO - Running setup.py (path:/tmp/pip-NABnZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:30 INFO - Running setup.py (path:/tmp/pip-mwqNwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:30 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)) 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:30 INFO - Running setup.py (path:/tmp/pip-Ed8PPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:31 INFO - Running setup.py (path:/tmp/pip-3Tp_rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:31 INFO - Running setup.py (path:/tmp/pip-LcUv_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:31 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)) 08:52:31 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)) 08:52:31 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)) 08:52:31 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)) 08:52:31 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)) 08:52:31 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)) 08:52:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:31 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 08:52:31 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 08:52:31 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 08:52:31 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 08:52:31 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 08:52:31 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 08:52:33 INFO - Downloading blessings-1.6.tar.gz 08:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:33 INFO - Installing collected packages: blessings 08:52:33 INFO - Running setup.py install for blessings 08:52:33 INFO - Successfully installed blessings 08:52:33 INFO - Cleaning up... 08:52:33 INFO - Return code: 0 08:52:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:33 INFO - Reading from file tmpfile_stdout 08:52:33 INFO - Current package versions: 08:52:33 INFO - argparse == 1.2.1 08:52:33 INFO - blessings == 1.6 08:52:33 INFO - blobuploader == 1.2.4 08:52:33 INFO - docopt == 0.6.1 08:52:33 INFO - functools32 == 3.2.3-2 08:52:33 INFO - jsonschema == 2.5.1 08:52:33 INFO - manifestparser == 1.1 08:52:33 INFO - mozInstall == 1.12 08:52:33 INFO - mozcrash == 0.17 08:52:33 INFO - mozdebug == 0.1 08:52:33 INFO - mozdevice == 0.48 08:52:33 INFO - mozfile == 1.2 08:52:33 INFO - mozhttpd == 0.7 08:52:33 INFO - mozinfo == 0.9 08:52:33 INFO - mozleak == 0.1 08:52:33 INFO - mozlog == 3.3 08:52:33 INFO - moznetwork == 0.27 08:52:33 INFO - mozprocess == 0.23 08:52:33 INFO - mozprofile == 0.28 08:52:33 INFO - mozrunner == 6.12 08:52:33 INFO - mozscreenshot == 0.1 08:52:33 INFO - mozsystemmonitor == 0.3 08:52:33 INFO - moztest == 0.7 08:52:33 INFO - mozversion == 1.4 08:52:33 INFO - psutil == 3.1.1 08:52:33 INFO - requests == 1.2.3 08:52:33 INFO - wsgiref == 0.1.2 08:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 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 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:33 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 08:52:33 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 08:52:33 INFO - Using env: {'DISPLAY': ':0', 08:52:33 INFO - 'HOME': '/home/cltbld', 08:52:33 INFO - 'LANG': 'en_US.UTF-8', 08:52:33 INFO - 'LANGUAGE': 'en_US:en', 08:52:33 INFO - 'LOGNAME': 'cltbld', 08:52:33 INFO - 'MAIL': '/var/mail/cltbld', 08:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:33 INFO - 'MOZ_NO_REMOTE': '1', 08:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:33 INFO - 'NO_EM_RESTART': '1', 08:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:33 INFO - 'PWD': '/builds/slave/test', 08:52:33 INFO - 'SHELL': '/bin/bash', 08:52:33 INFO - 'SHLVL': '1', 08:52:33 INFO - 'TERM': 'linux', 08:52:33 INFO - 'TMOUT': '86400', 08:52:33 INFO - 'USER': 'cltbld', 08:52:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:33 INFO - '_': '/tools/buildbot/bin/python'} 08:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 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)) 08:52:33 INFO - Cleaning up... 08:52:33 INFO - Return code: 0 08:52:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', '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 08:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:33 INFO - Using env: {'DISPLAY': ':0', 08:52:33 INFO - 'HOME': '/home/cltbld', 08:52:33 INFO - 'LANG': 'en_US.UTF-8', 08:52:33 INFO - 'LANGUAGE': 'en_US:en', 08:52:33 INFO - 'LOGNAME': 'cltbld', 08:52:33 INFO - 'MAIL': '/var/mail/cltbld', 08:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:33 INFO - 'MOZ_NO_REMOTE': '1', 08:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:33 INFO - 'NO_EM_RESTART': '1', 08:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:33 INFO - 'PWD': '/builds/slave/test', 08:52:33 INFO - 'SHELL': '/bin/bash', 08:52:33 INFO - 'SHLVL': '1', 08:52:33 INFO - 'TERM': 'linux', 08:52:33 INFO - 'TMOUT': '86400', 08:52:33 INFO - 'USER': 'cltbld', 08:52:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:33 INFO - '_': '/tools/buildbot/bin/python'} 08:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:33 INFO - Cleaning up... 08:52:33 INFO - Return code: 0 08:52:33 INFO - Running post-action listener: _resource_record_post_action 08:52:33 INFO - Running post-action listener: _start_resource_monitoring 08:52:33 INFO - Starting resource monitoring. 08:52:33 INFO - [mozharness: 2016-07-30 15:52:33.997554Z] Finished create-virtualenv step (success) 08:52:33 INFO - [mozharness: 2016-07-30 15:52:33.998028Z] Running install step. 08:52:33 INFO - Running pre-action listener: _resource_record_pre_action 08:52:33 INFO - Running main action method: install 08:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:34 INFO - Reading from file tmpfile_stdout 08:52:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:34 INFO - Reading from file tmpfile_stdout 08:52:34 INFO - Output received: 08:52:34 INFO - Usage: mozinstall [options] installer 08:52:34 INFO - Options: 08:52:34 INFO - -h, --help show this help message and exit 08:52:34 INFO - -d DEST, --destination=DEST 08:52:34 INFO - Directory to install application into. [default: 08:52:34 INFO - "/builds/slave/test"] 08:52:34 INFO - --app=APP Application being installed. [default: firefox] 08:52:34 INFO - mkdir: /builds/slave/test/build/application 08:52:34 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'] 08:52:34 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 08:52:50 INFO - Reading from file tmpfile_stdout 08:52:50 INFO - Output received: 08:52:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:50 INFO - Running post-action listener: _resource_record_post_action 08:52:50 INFO - [mozharness: 2016-07-30 15:52:50.326583Z] Finished install step (success) 08:52:50 INFO - [mozharness: 2016-07-30 15:52:50.326860Z] Running run-tests step. 08:52:50 INFO - Running pre-action listener: _resource_record_pre_action 08:52:50 INFO - Running main action method: run_tests 08:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:50 INFO - Python 2.7.3 08:52:50 INFO - Return code: 0 08:52:50 INFO - grabbing minidump binary from tooltool 08:52:50 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')]} 08:52:50 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 0x24bd3b0>, '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 0x24be2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24be740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:50 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 08:52:50 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 08:52:50 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 08:52:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:50 INFO - Return code: 0 08:52:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 08:52:50 INFO - Using env: {'DISPLAY': ':0', 08:52:50 INFO - 'HOME': '/home/cltbld', 08:52:50 INFO - 'LANG': 'en_US.UTF-8', 08:52:50 INFO - 'LANGUAGE': 'en_US:en', 08:52:50 INFO - 'LOGNAME': 'cltbld', 08:52:50 INFO - 'MAIL': '/var/mail/cltbld', 08:52:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:50 INFO - 'MOZ_NO_REMOTE': '1', 08:52:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:50 INFO - 'NO_EM_RESTART': '1', 08:52:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:50 INFO - 'PWD': '/builds/slave/test', 08:52:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:50 INFO - 'SHELL': '/bin/bash', 08:52:50 INFO - 'SHLVL': '1', 08:52:50 INFO - 'TERM': 'linux', 08:52:50 INFO - 'TMOUT': '86400', 08:52:50 INFO - 'USER': 'cltbld', 08:52:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088', 08:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:50 INFO - '_': '/tools/buildbot/bin/python'} 08:52:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:52:50 INFO - mozversion application_buildid: 20160730072526 08:52:50 INFO - mozversion application_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 08:52:50 INFO - mozversion application_display_name: Nightly 08:52:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:50 INFO - mozversion application_name: Firefox 08:52:50 INFO - mozversion application_remotingname: firefox 08:52:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:52:50 INFO - mozversion application_vendor: Mozilla 08:52:50 INFO - mozversion application_version: 50.0a1 08:52:50 INFO - mozversion platform_buildid: 20160730072526 08:52:50 INFO - mozversion platform_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 08:52:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:52:50 INFO - mozversion platform_version: 50.0a1 08:52:50 INFO - using testdate: 1469893970 08:52:50 INFO - actual date: 1469893970 08:52:50 INFO - starting webserver on 'localhost:53503' 08:52:50 INFO - SUITE-START | Running 2 tests 08:52:50 INFO - TEST-START | dromaeo_css 08:52:50 INFO - operating with platform_type : linux_ 08:52:50 INFO - Initialising browser for dromaeo_css test... 08:52:50 INFO - TEST-INFO | started process 29247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptY_6t2/profile http://localhost:53503/getInfo.html) 08:52:54 INFO - PROCESS | 29247 | __metrics Screen width/height:1600/1200 08:52:54 INFO - PROCESS | 29247 | colorDepth:24 08:52:54 INFO - PROCESS | 29247 | Browser inner width/height: 1024/697 08:52:54 INFO - PROCESS | 29247 | __metrics 08:52:55 INFO - PROCESS | 29247 | 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" 08:52:55 INFO - PROCESS | 29247 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:56 INFO - TEST-INFO | 29247: exit 0 08:52:56 INFO - Browser initialized. 08:52:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:56 INFO - TEST-INFO | started process 29326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptY_6t2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:08 INFO - PROCESS | 29326 | RSS: Main: 157679616 08:53:08 INFO - PROCESS | 29326 | 08:54:00 INFO - PROCESS | 29326 | 1469894040706 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] 08:56:12 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53503/tests/dromaeo/cssquery-ext.html) 08:56:13 INFO - PROCESS | 29326 | RSS: Main: 252715008 08:56:13 INFO - PROCESS | 29326 | 08:59:16 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-ext.html (next: http://localhost:53503/tests/dromaeo/cssquery-jquery.html) 08:59:17 INFO - PROCESS | 29326 | RSS: Main: 245506048 08:59:17 INFO - PROCESS | 29326 | 09:02:19 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53503/tests/dromaeo/cssquery-mootools.html) 09:02:19 INFO - PROCESS | 29326 | RSS: Main: 188919808 09:02:19 INFO - PROCESS | 29326 | 09:05:22 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53503/tests/dromaeo/cssquery-prototype.html) 09:05:22 INFO - PROCESS | 29326 | RSS: Main: 188432384 09:05:22 INFO - PROCESS | 29326 | 09:08:25 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53503/tests/dromaeo/cssquery-yui.html) 09:08:26 INFO - PROCESS | 29326 | RSS: Main: 187858944 09:08:26 INFO - PROCESS | 29326 | 09:11:28 INFO - PROCESS | 29326 | Cycle 1(1): loaded http://localhost:53503/tests/dromaeo/cssquery-yui.html (next: http://localhost:53503/tests/dromaeo/cssquery-dojo.html) 09:11:29 INFO - PROCESS | 29326 | RSS: Main: 282402816 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | __start_tp_report 09:11:29 INFO - PROCESS | 29326 | _x_x_mozilla_page_load 09:11:29 INFO - PROCESS | 29326 | _x_x_mozilla_page_load_details 09:11:29 INFO - PROCESS | 29326 | |i|pagename|runs| 09:11:29 INFO - PROCESS | 29326 | |0;dojo.html;2641.8811153498095;2647.9470410591775;2682.9597556036665;2690.2601784509257;2691.1119330620886;4635.837745678902;4683.508231635672;4767.213409787381;4899.559039686427;4914.729689867056;4689.976550117244;4768.73771942543;4774.355462012627;4798.712077275366;4842.443119041312;4354.976580503587;4370.082282720617;4445.1331990261915;4493.213687604656;4553.567411095941;4426.380306757057;4504;4518.164139634178;4526.841560545382;4537.4328208973875;4311.094670119247;4312.913741725148;4370.628496577795;4378.9562104378865;4432.623227025707;4336.3712261722185;4385.780710964471;4387.868363949086;4402.955970440319;4446.622037126848;4435.911281774379;4438.400815889846;4448.065906159711;4477.507474177838;4489.079738653568;4573.977130114328;4679.74261415622;4780.163471392527;4873.634477414208;4880.975595122037;5085.440601533828;5191.610629202825;5191.792328306863;5194.11700010999;5197.610179236534;5162.406323272834;5176.042432150064;5181.766820493087;5215.556677682402;5226.712530810804;4636.629069674418;4765.237561990134;4801.111794318027;4829.73436460998;4853.126437241331;5293.920591191135;5316.3354580677415;5353.464653534693;5363.704996225167;5365.08793505105;5094.4141423736;5097.388313402341;5150.97424512875;5154.252633368141;5156.587473002151;4983.277424773388;5040.899182016339;5043.722595257296;5183.974080129575;5233.319668443078;5071.518205770446;5072.239164125411;5079.161938280143;5103.515166059218;5129.384473863161;5053.84838454847;5060.84817455477;5065.290859279704;5078.415982162025;5117.488251174853;4283.2290187765875;4304.332828411601;4322.37325587788;4384.539623339567;4423.20382331177;3772.0569857535615;3795.411711184771;3838.4626152338137;3873.748206366577;3895.7467764595212;4350.086481838849;4355.390245365651;4361.5856493633055;4362.432883725159;4406.537313582027;4886.755662216875;4937.851864444073;5133.383993920754;5139.537441630271;5163.690178589297;4347.826086956549;4405.31717583775;4408.625266852354;4410.933835992462;4474.619657329098;4693.436787585511;4708.4820669726305;4711.387519622427;4717.740524271198;4765.9523404766205;4591.8392856249875;4858.95141048585;4890.290907818347;4913.754312284443;4948.406191257072;5103.897922041612;5148.43367229612;5158.277841102324;5206.297149884717;5225.973870130625;4872.902541949212;4884.755762211804;4887.144749668865;4892.510748925221;4933.358663373739;4831.444383895897;5120.206368012964;5123.001014802227;5123.513266239701;5125.666831655931;5060.240963855451;5141.151709967813;5149.819756308511;5195.870103247449;5225.216217567396;5066.4680208577565;5082.3138876252715;5084.41529224144;5084.8220312288895;5131.409887862795;4857.805687772449;5075.492450754895;5078.466760990191;5081.898362032664;5081.932794113278;4861.927071094007;4875.731834749123;4906.877328066684;5004;5006.649534532694;5035.420926593489;5074.31496747949;5081.669691470042;5084.694918304914;5129.769160387867;4750.976245118753;4960.355153829979;4967.230079337708;4969.4782047884455;4977.651564390458 09:11:29 INFO - PROCESS | 29326 | |1;ext.html;564.785381555009;565.0958466453673;568.7923907773659;576.2940398012433;583.5564970622326;27537.173884783464;38715.80642096789;40277.59722402775;40587.59412405882;44597.55402445982;40951.79524102383;41276.79361603188;41358.793206034;41360.172796544124;41488;7383.556986580822;7780.260875216845;7915.8416831663335;7924.484908480959;7930.325922296612;7590.316871481566;7690.692372305101;7699.730509432171;9837.606495740161;10100.898991010106;10269.127124194452;10321.58713651453;10328.431936243504;10329.070383665468;10335.586576536929;10141.645042423479;10180.38917664935;10219.029192226726;10222.386656800616;10229.386236825778;10014.9499252504;10047.899521004843;10074.294799364048;10080.193584513221;10081.899181008243;40001.59998400008;40037.59962400368;40376.59623403758;40437.79781101105;40439.98900027493;3022.123584160591;3043.3152540678393;3046.8781248750024;3169.4928811390296;3358.3115461330367;30351.544726829114;30489.390212195853;30504.54243186354;30553.847230763702;31874.681253187402;3295.6045274566964;3337.6996070353543;3338.6661333866664;3340.3820293245826;3410.60778010527;186451;187017;187464;187742;187769;32005.199870003435;54702.72648636731;54914.72542637261;55098.17352739632;55156.44843551513;32605.673943260263;33772.831135844164;34297.828510857784;34312.828435857664;34329.53716016902;13565.864341356657;13619.250941198132;13672.453101875813;13677.931610341884;13686.178829270077;11215.55137794479;11281.097512199005;11285.37930413835;11290.943545282222;11302.265352752045;7358.337749602454;7545.622718864035;7552.546847189186;7686.807829804299;7778.88331675014;3104.5964024676646;3141.167590588496;3150.984245078806;3191.824449655291;3225.9838700806813;859.8538248497771;885.0618344554792;890.3900827932887;913.488446469979;955.9904400956041;28456.573151402747;28596.571051434246;28740.137795866158;29131.85434072816;29304;977.8435450327913;994.2741798487145;1026.9781567340394;1029.5727273181546;1043.8747350317858;14709.264536773333;15320;15421.383144674088;15484.92257538705;15636.68726625484;398899;402227;402897;402906;403160;44446.55553444489;50306.245406318936;51105.48894511082;51116;51146.48853511491;1175.488662431845;1199.5201919232377;1211.4124649544963;1217.1236709569096;1234.6913271682258;28666.283342915758;29597.26006849846;29898.402031958805;30511.389772203987;30718.84640576783;43588.56411435845;47017;48213.75893120512;48358.758206208746;53512.46487535231;356855;363829;366713;368306;369834;37453.4381984265;37484.81257593694;37556.624433756406;37755;37802;40366;40404.59595404008;40604.3909341366;40840.79579602083;41369;34372.65627343694;34539.13652158716;34684;35251.47122793109;35360;35887.102822428606;35992.820035899655;36102.4584631236;36398.8180059098;36430.27139457249;35319.64680353266;35332.64667353294;35535.46696799602;36556.451653225755;38674.4198837012;32163.195920102185;34210.65789342075;34655.13362165966;34778;34819;25600.48799023972;25667.229983100537;25945.740542594333;25970.610440843026;26041.609375859756 09:11:29 INFO - PROCESS | 29326 | |2;jquery.html;337.24457215836503;351.5465050085388;359.2796443131521;360.4881068882186;386.25452875949424;12864;16233.756493652605;16405.179741012947;17482.737758933625;17638.38265660702;16782.244798984044;17003.149842507886;17215.22531486083;17368.305267789274;17473.91263043683;4994.200927851544;5050.318207042057;5133.435322114565;5153.252778347138;5159.380874295071;3763.5671897731836;5089.796408143669;5180.740962951837;5701.543876489871;6001.759929602833;6013.1581578579035;6026.728797204114;6037.184980027706;6039.667818269993;6041.546883983697;5186.455422180673;5435.211894275308;5458.2904222451225;5500.3949565547755;6028.4574388305045;5289.629725919187;5320.733963301819;5361.5978801589645;5364.6512976656395;5368.141097424394;11800.055995520337;11926;11957.701057473545;12043.156979011474;12135.271883687006;1841.0518582929801;1932.3526618582791;2026.2604149485478;2069.2550681754556;2266.8665667166415;8986.731302631264;9430.764230894214;9474.194693451065;10593.78812423755;12047.879521204763;1708.2654458582804;1748.7376893465955;1752.956176095595;1760.6566719489704;1791.5073354827528;67304.66347668279;69719.30280697178;69865.3013469864;70597.64701176513;71727.64136179286;9995.500224988722;10156.593736250616;10206.081452669296;10401.167906567607;10844.078253348396;13774.724505509834;13797.172169669851;13800.171989680652;13825.723485530434;13826.101303415246;6973.93026069743;7177.856442871113;7187.281271872876;7251.456140789462;7355.080614923135;6770.221424536241;6796.592204467748;6934.341237582422;6954.269801670752;7069.187043489962;4204.159168166379;4242.893927651771;4307.913841723148;4367.519572846984;4410.713303635253;1798.9280428782963;1840.0983518076046;1841.6500864835907;1851.6389304085844;1884.8303652671325;693.6393075600761;808.9919100809034;915.2997956563235;926.1710768861831;933.0016881936399;16431.26059327333;16685.49943501697;17211.827881721274;17346.132693365533;17676.381326653507;866.8526350520426;870.9433886797337;925.9583318750672;947.2280091725222;953.8903026151943;7016.649167541603;9292.766029622415;9728.367656102331;9877.654282100235;9886;383459.33081338217;388681;402464;402866;404927;55803.72098139564;76941;77905;78080.60959695165;80682.59658701786;855.5465603230298;864.4935903129244;874.2481465939287;883.8497455432592;884.9557522123868;15254.389824406899;15460.304286306919;15567.221638917783;15937.442189523312;15966.760498592297;36299.27401451903;36865.815670921475;36918.815405922796;37121.81439092895;37414.99999999891;46652.7667361661;49995;51126;52167.73916130395;52840.20739688985;6011.008183649649;6341.460975817107;7657.961710191414;7769.494982826098;7894.723684671009;9693.9030609693;10609.575616975235;11417.60038398652;11744.119191060534;11830.822537662114;6194.38056194377;9319.440833550008;9447.716568502956;9547.522623868917;9593.712188634352;9446.858297125686;9513.90486095158;9836.901630983599;9873.210143188671;10261.897381026094;9479.336446448959;9502.144806967406;9913.45475998827;9981.301308908307;10315.071643552117;7340.339369456561;7492.51298665585;7514.8872766909635;7517;7750.759878419426;8382.622781974947;9602.231821454126;9645.37305075168;9934.304598678023;10215.846762298721 09:11:29 INFO - PROCESS | 29326 | |3;mootools.html;1371.8765311121997;1400.0829456705858;1460.9415623375066;1663.2432243329285;1704.5823773175566;7093.680784364703;7524.473286869921;7527.510711803736;7530.209328020561;7534.321911028;6233.283172435172;6969.19854216764;7146.74986375477;7196.424286057116;7356.816079598013;2125.3836387447623;2153.12798316682;2157.611629906616;2157.6763485477145;2160.9351719448364;2143.47484866208;2164.891755412223;2183.759786423492;2187.059564387313;2187.7155969723913;2148.4414052346347;2149.419656692692;2169.0889826273005;2169.3708824440973;2175.042981088324;2107.620628286908;2111.5882402931434;2113.144176608476;2114.270576651053;2114.925977590792;2038.6840039793856;2090.9790902090936;2092.6502405948077;2092.79072092791;2094.5077906691913;7216.855662886713;7316.890246646304;7337.669804858794;7351.926480735231;7357.484976051678;4406.162829062468;4485.170243504962;4506.797194126272;4516.480604730433;4521.412216411878;2628.5531459651907;2738.6165936768866;2820.3936153727045;2842.2752198189537;2844.1467559732205;855.234565064264;896.0412358776113;896.5741272895388;899.2895612466144;904.4980036079972;9792.412455252708;9835.950820245924;9837.016298370107;9840.065193806577;9861.260405469618;3868.3810590305416;3934.272159650474;4092.7748973806133;4127.174565086934;4163.375493675972;8506.872396914052;8546;8556.871646925301;8568.528730919734;8571;4516.096780643885;4520.050789334211;4525.411696479437;4533.977330113328;4539.16025535277;3622.0763705255517;3893.124047089382;4013.7190396671954;4160.188763191149;4163.604457576525;3543.94684079739;3549.1304630365207;3665.2303016366327;3668.559772827278;3781.4516895050615;1167.486306025346;1189.1378750405886;1204.9819252711216;1208.2206976500108;1217.9695507612203;852.1606217875387;856.7760938572895;870.425519157353;883.4743327719997;909.231699214163;4980.8256711015665;5073.822416215488;5143.099957507421;5155;5189.065968125774;415.36034506859704;417.3135192608203;417.39060970982706;421.9662427005832;424.0458967323522;3569.464580312974;3651.835667394974;3692.4276737105793;3697.186618943828;3772.1512659651908;8763.56182190888;9062.773430664287;9192.356535042616;9198.77003074915;9198.908010919806;9140.63437462494;9161.312901532412;9166.450012999108;9168.129027742354;9173.541322933826;6567.1462709848365;6738.258791532928;6906.861862762717;7022.192447868459;7052.858942821217;5300.31095957523;5399.946000539944;5400.702961337164;5411.621186516906;5611.691356975405;8207.425480216327;8256.628451719807;8259.752207433787;8317.625706843086;8396.538190399586;8137.837243254983;8328.875066873881;8408.201220884006;8468.110848360833;8526.062133165471;5741.1388291756575;6316.684165791784;6617.702203400955;6771.898421523582;6778.661066946534;7010.193827709879;7178.102737157856;7221.350078492751;7225.24134965821;7231.8553628928175;6395;6422.229332480132;6476.384743449365;6485.481161506974;6601.33986601336;6311.211098612674;6316.147320111726;6400.135981642418;6414.486841052611;6442.967785161044;5904.852378690567;5993.220881285405;5997.640141591519;5997.700114994145;6002.549808764273;4350.71720338177;4378.562143785596;4385.320275357325;4461.977690111528;4571.49713531518;4224.640905522942;4405.40527028847;4469.821207151677;4474.37358769766;4497.617702495194 09:11:29 INFO - PROCESS | 29326 | |4;prototype.html;279.0762575873857;284.8960129552713;286.7419322609651;296.8678937872646;298.7893535057784;4946.554810067093;4956.776945037473;4997.450280469146;4999.07517109335;5007.399112106547;4897.649128418352;4901.852944411665;4914.262860570916;4960.900781984358;4996.800127994885;3642.872499462526;3750.6061863504347;3838.9808050959846;3868;3880.670143037831;3898.200868821899;3914.4128380742973;3930.5630509084267;3931.036895960494;3932.8959006931295;3844.5770965193806;3874.128321127752;3876.476675648794;3880.3597406427907;3899.473571067912;3548.6273941236313;3626.6554677305744;3676.724245681558;3833.3291673956946;3890.0469385000715;3394.100563350714;3395.558577384949;3405.387030334539;3427.5544179256785;3436.350551735181;4822.083804077214;4861.489543597907;4870.879697669556;4881.730750004989;4884.803223210336;4106.342985122366;4296.312589985588;4446.333050042519;4451.109778044404;4451.666125040602;5126.41116236302;5134.919048570865;5143.871403214912;5216.347956505437;5229.869253268661;3670.5228320318456;3672.8530858765616;3673.485712000322;3679.7240206984584;3687.815609219555;5348.786048558053;5385.892282154335;5435.456454354572;5459.454054594548;5479.287692599976;3698.6315063426705;3700.4634328022285;3704.5554533456157;3707.629237076271;3708.3695771718335;3736.860257621397;3741;3752.774833509998;3780.432935059708;3790.488284081669;4358.193734159191;4367.563243675607;4370.890727731832;4375.496817865923;4378.890527736832;5107.361579802525;5143.12566863634;5193.818216362409;5198.792048318025;5255.947440525546;1290.9354532273348;1306.6276111308232;1309.8035294705871;1311.344327836082;1317.4071667749552;786.2294950948103;826.8263664630375;832.629479881459;836.4981011393115;838.995805020971;4115.71190016696;4371.912561748747;4421.53573874745;4556.931646025312;4597.551900997262;5330.92003619946;5341.252224688546;5355.437679043722;5365.382980957162;5393.568514518829;4539.387182730289;4545.318202269686;4557;4561.589456948891;4568.634509239253;2726.5413004042744;2800.8599570021415;2802.7337402946687;2805.5370863807652;2806.466771313444;4998.975005124951;5013.774380152902;5014.373203349582;5039.135519857676;5056.494350564914;5242.318498595158;5393.568514518829;5420.945790542123;5527.226188333637;5537.363203231599;4956.479569645279;4958.6776859504735;4987.600991920638;4999.675086102186;5020.698758074454;5280.049591073644;5303.946960530346;5306.575473962151;5313.3889602694635;5334.253204551288;4982.65815066918;5222.843314700413;5231.136862417658;5252.448492908343;5252.501012403815;4981.701097934136;5004.274380214775;5013.674111182761;5038.596912246938;5039.344885165052;3667.541557305337;3669.9633003669624;3690.1881586051027;3699.6300369963865;3704.388775851954;5221.738913054256;5327.573794096385;5388.865278368072;5391.409534187345;5406.324209473816;5144.964470962151;5149.58386443716;5151.974240128776;5159.832870194602;5174.14626586609;5131.384233891957;5136.357955255593;5140.30605868203;5221.869453263547;5235.842924712265;4925.827596034122;5017.272495488207;5085.4914508548845;5102.923456148086;5112.182050871843;4959.479254678206;5104.591632669451;5162.380514338303;5187.636865419385;5229.346331708536;4942.728149951643;4993.950060499348;4994.675346102492;4998.825041123543;5064.848054558369 09:11:29 INFO - PROCESS | 29326 | |5;yui.html;640.8539428390027;650.1353200243676;655.7475371981787;656.7996760987896;666.1941182593698;12504.56234031809;13631.863681363184;13660.658483537916;13665.521706740266;13679.110857794261;11466.770664586704;12534.937325313384;12563.246205227693;12673.986081113511;12690.238585684865;769.0771074710342;780.1769133564088;788.3338578900848;789.6367670871406;789.7986013566561;788.1606089514677;789.2265579731866;790;790.1032328307355;790.1624278265028;823.2508417340222;824.4558591329724;824.7773101262655;825.1995564302647;825.529448214518;814.7392834293029;816.873384625384;817.2195553246635;817.4441379861692;817.6811043692965;611.2634275697774;612.3386742318286;612.5558969746943;612.7212118486078;613.1446631948452;11404.714882128013;11412.42937853104;11445.484953177043;11448.084153267719;11452.828207576893;10813.08088812452;10839.458027098692;11017.669469915916;11047.83428248577;11148.665540033811;9415.668276012771;9471.526423678788;9667.564959576766;9671.90328096717;9896.653617123438;3144.2768163322335;3174.9047528573947;3187.123541026213;3219.356128774231;3317.5853018372704;58951.705241473945;59880;60294.69852650753;61718.38281617171;61939.38060619426;8213.876791848126;8271.586420678943;8300.2114799094;8317.376196785266;8328.167183281623;16879;16896.239669214916;16966.91516542434;16971.91514042422;17012.234449449803;6401.167848179707;6536.509761767887;6784.525083244125;6797.5581587196675;6842.516588597785;3534.5228394166975;3601.9279614407565;3680.227152297994;3689.9077523062138;3775.3959366501226;2925.517289647227;2986.77599180058;2994.2813724705916;3002.894898678536;3005.233665415305;482.2115840600643;494.8094983431405;499.1439680947193;501.70900877490965;503.68519675203;604.3412680178538;608.2913405882186;630.3790766095392;637.4263163153106;642.1491523731075;8613.741587752378;8755.387122901337;8797.38418310712;8862.291016718777;8941.721434793004;499.4580879745444;520.4093354043189;561.8230257468884;590.5275779376482;602.256213576233;4038.7778672172726;4134.937975930364;4228.936565951513;4237.618614324664;4292.613664770186;92427;92575.5371223153;92801.53599231961;95785;96449.51775241079;56010;69592;70297.2970270301;80464.59767701125;81694.59152704198;70613.2938670617;72264;73652.63173684204;73698.2630173702;74615;8607.827843443221;9012.684556040507;9015.77460563465;9025.81948361016;9288.256939444964;41596.58403415927;42574.36138457864;42854.35718464288;43093.569064308955;43745.34381984209;53796.19305710496;58349.416505836096;58926.410735892096;60532;62428;11163.330200188015;11414;11563.6530904073;11646.534138634699;11933.164678472423;12697.42861571213;12908.483660653468;13152.539661111816;13406.195628262336;13662.863371366158;12566.560170393992;12738.490460381481;13016.349182540645;13262.867371326163;13390.464381424634;12142.150049496451;12253.576532568595;12288.1398302118;12869.420876060787;12914.935425322814;11932.880671193177;12057;12370.072244581872;12375.504979800708;12746.553870614483;10022.599096036078;10062.647807326708;10522.421266830397;10528.631497897843;10851.782964340828;9886.50567471638;10860.294080884718;10869.619563315562;10966.067884229611;10966.17753668494 09:11:29 INFO - PROCESS | 29326 | __end_tp_report 09:11:29 INFO - PROCESS | 29326 | __start_cc_report 09:11:29 INFO - PROCESS | 29326 | _x_x_mozilla_cycle_collect,1024 09:11:29 INFO - PROCESS | 29326 | __end_cc_report 09:11:29 INFO - PROCESS | 29326 | __startTimestamp1469895089077__endTimestamp 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | ------- Summary: start ------- 09:11:29 INFO - PROCESS | 29326 | Number of tests: 6 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#0] dojo.html Cycles:165 Average:4755.36 Median:4886.76 stddev:505.55 (10.3%) stddev-sans-first:479.15 09:11:29 INFO - PROCESS | 29326 | Values: 2641.9 2647.9 2683.0 2690.3 2691.1 4635.8 4683.5 4767.2 4899.6 4914.7 4690.0 4768.7 4774.4 4798.7 4842.4 4355.0 4370.1 4445.1 4493.2 4553.6 4426.4 4504.0 4518.2 4526.8 4537.4 4311.1 4312.9 4370.6 4379.0 4432.6 4336.4 4385.8 4387.9 4403.0 4446.6 4435.9 4438.4 4448.1 4477.5 4489.1 4574.0 4679.7 4780.2 4873.6 4881.0 5085.4 5191.6 5191.8 5194.1 5197.6 5162.4 5176.0 5181.8 5215.6 5226.7 4636.6 4765.2 4801.1 4829.7 4853.1 5293.9 5316.3 5353.5 5363.7 5365.1 5094.4 5097.4 5151.0 5154.3 5156.6 4983.3 5040.9 5043.7 5184.0 5233.3 5071.5 5072.2 5079.2 5103.5 5129.4 5053.8 5060.8 5065.3 5078.4 5117.5 4283.2 4304.3 4322.4 4384.5 4423.2 3772.1 3795.4 3838.5 3873.7 3895.7 4350.1 4355.4 4361.6 4362.4 4406.5 4886.8 4937.9 5133.4 5139.5 5163.7 4347.8 4405.3 4408.6 4410.9 4474.6 4693.4 4708.5 4711.4 4717.7 4766.0 4591.8 4859.0 4890.3 4913.8 4948.4 5103.9 5148.4 5158.3 5206.3 5226.0 4872.9 4884.8 4887.1 4892.5 4933.4 4831.4 5120.2 5123.0 5123.5 5125.7 5060.2 5141.2 5149.8 5195.9 5225.2 5066.5 5082.3 5084.4 5084.8 5131.4 4857.8 5075.5 5078.5 5081.9 5081.9 4861.9 4875.7 4906.9 5004.0 5006.6 5035.4 5074.3 5081.7 5084.7 5129.8 4751.0 4960.4 4967.2 4969.5 4977.7 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#1] ext.html Cycles:180 Average:47207.30 Median:34669.57 stddev:87755.25 (253.1%) stddev-sans-first:87931.55 09:11:29 INFO - PROCESS | 29326 | Values: 564.8 565.1 568.8 576.3 583.6 27537.2 38715.8 40277.6 40587.6 44597.6 40951.8 41276.8 41358.8 41360.2 41488.0 7383.6 7780.3 7915.8 7924.5 7930.3 7590.3 7690.7 7699.7 9837.6 10100.9 10269.1 10321.6 10328.4 10329.1 10335.6 10141.6 10180.4 10219.0 10222.4 10229.4 10014.9 10047.9 10074.3 10080.2 10081.9 40001.6 40037.6 40376.6 40437.8 40440.0 3022.1 3043.3 3046.9 3169.5 3358.3 30351.5 30489.4 30504.5 30553.8 31874.7 3295.6 3337.7 3338.7 3340.4 3410.6 186451.0 187017.0 187464.0 187742.0 187769.0 32005.2 54702.7 54914.7 55098.2 55156.4 32605.7 33772.8 34297.8 34312.8 34329.5 13565.9 13619.3 13672.5 13677.9 13686.2 11215.6 11281.1 11285.4 11290.9 11302.3 7358.3 7545.6 7552.5 7686.8 7778.9 3104.6 3141.2 3151.0 3191.8 3226.0 859.9 885.1 890.4 913.5 956.0 28456.6 28596.6 28740.1 29131.9 29304.0 977.8 994.3 1027.0 1029.6 1043.9 14709.3 15320.0 15421.4 15484.9 15636.7 398899.0 402227.0 402897.0 402906.0 403160.0 44446.6 50306.2 51105.5 51116.0 51146.5 1175.5 1199.5 1211.4 1217.1 1234.7 28666.3 29597.3 29898.4 30511.4 30718.8 43588.6 47017.0 48213.8 48358.8 53512.5 356855.0 363829.0 366713.0 368306.0 369834.0 37453.4 37484.8 37556.6 37755.0 37802.0 40366.0 40404.6 40604.4 40840.8 41369.0 34372.7 34539.1 34684.0 35251.5 35360.0 35887.1 35992.8 36102.5 36398.8 36430.3 35319.6 35332.6 35535.5 36556.5 38674.4 32163.2 34210.7 34655.1 34778.0 34819.0 25600.5 25667.2 25945.7 25970.6 26041.6 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#2] jquery.html Cycles:180 Average:24081.48 Median:52503.97 stddev:65446.15 (124.6%) stddev-sans-first:65605.46 09:11:29 INFO - PROCESS | 29326 | Values: 337.2 351.5 359.3 360.5 386.3 12864.0 16233.8 16405.2 17482.7 17638.4 16782.2 17003.1 17215.2 17368.3 17473.9 4994.2 5050.3 5133.4 5153.3 5159.4 3763.6 5089.8 5180.7 5701.5 6001.8 6013.2 6026.7 6037.2 6039.7 6041.5 5186.5 5435.2 5458.3 5500.4 6028.5 5289.6 5320.7 5361.6 5364.7 5368.1 11800.1 11926.0 11957.7 12043.2 12135.3 1841.1 1932.4 2026.3 2069.3 2266.9 8986.7 9430.8 9474.2 10593.8 12047.9 1708.3 1748.7 1753.0 1760.7 1791.5 67304.7 69719.3 69865.3 70597.6 71727.6 9995.5 10156.6 10206.1 10401.2 10844.1 13774.7 13797.2 13800.2 13825.7 13826.1 6973.9 7177.9 7187.3 7251.5 7355.1 6770.2 6796.6 6934.3 6954.3 7069.2 4204.2 4242.9 4307.9 4367.5 4410.7 1798.9 1840.1 1841.7 1851.6 1884.8 693.6 809.0 915.3 926.2 933.0 16431.3 16685.5 17211.8 17346.1 17676.4 866.9 870.9 926.0 947.2 953.9 7016.6 9292.8 9728.4 9877.7 9886.0 383459.3 388681.0 402464.0 402866.0 404927.0 55803.7 76941.0 77905.0 78080.6 80682.6 855.5 864.5 874.2 883.8 885.0 15254.4 15460.3 15567.2 15937.4 15966.8 36299.3 36865.8 36918.8 37121.8 37415.0 46652.8 49995.0 51126.0 52167.7 52840.2 6011.0 6341.5 7658.0 7769.5 7894.7 9693.9 10609.6 11417.6 11744.1 11830.8 6194.4 9319.4 9447.7 9547.5 9593.7 9446.9 9513.9 9836.9 9873.2 10261.9 9479.3 9502.1 9913.5 9981.3 10315.1 7340.3 7492.5 7514.9 7517.0 7750.8 8382.6 9602.2 9645.4 9934.3 10215.8 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#3] mootools.html Cycles:180 Average:4900.32 Median:5350.13 stddev:2680.70 (50.1%) stddev-sans-first:2675.10 09:11:29 INFO - PROCESS | 29326 | Values: 1371.9 1400.1 1460.9 1663.2 1704.6 7093.7 7524.5 7527.5 7530.2 7534.3 6233.3 6969.2 7146.7 7196.4 7356.8 2125.4 2153.1 2157.6 2157.7 2160.9 2143.5 2164.9 2183.8 2187.1 2187.7 2148.4 2149.4 2169.1 2169.4 2175.0 2107.6 2111.6 2113.1 2114.3 2114.9 2038.7 2091.0 2092.7 2092.8 2094.5 7216.9 7316.9 7337.7 7351.9 7357.5 4406.2 4485.2 4506.8 4516.5 4521.4 2628.6 2738.6 2820.4 2842.3 2844.1 855.2 896.0 896.6 899.3 904.5 9792.4 9836.0 9837.0 9840.1 9861.3 3868.4 3934.3 4092.8 4127.2 4163.4 8506.9 8546.0 8556.9 8568.5 8571.0 4516.1 4520.1 4525.4 4534.0 4539.2 3622.1 3893.1 4013.7 4160.2 4163.6 3543.9 3549.1 3665.2 3668.6 3781.5 1167.5 1189.1 1205.0 1208.2 1218.0 852.2 856.8 870.4 883.5 909.2 4980.8 5073.8 5143.1 5155.0 5189.1 415.4 417.3 417.4 422.0 424.0 3569.5 3651.8 3692.4 3697.2 3772.2 8763.6 9062.8 9192.4 9198.8 9198.9 9140.6 9161.3 9166.5 9168.1 9173.5 6567.1 6738.3 6906.9 7022.2 7052.9 5300.3 5399.9 5400.7 5411.6 5611.7 8207.4 8256.6 8259.8 8317.6 8396.5 8137.8 8328.9 8408.2 8468.1 8526.1 5741.1 6316.7 6617.7 6771.9 6778.7 7010.2 7178.1 7221.4 7225.2 7231.9 6395.0 6422.2 6476.4 6485.5 6601.3 6311.2 6316.1 6400.1 6414.5 6443.0 5904.9 5993.2 5997.6 5997.7 6002.5 4350.7 4378.6 4385.3 4462.0 4571.5 4224.6 4405.4 4469.8 4474.4 4497.6 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#4] prototype.html Cycles:180 Average:4281.97 Median:4951.52 stddev:1258.79 (25.4%) stddev-sans-first:1225.95 09:11:29 INFO - PROCESS | 29326 | Values: 279.1 284.9 286.7 296.9 298.8 4946.6 4956.8 4997.5 4999.1 5007.4 4897.6 4901.9 4914.3 4960.9 4996.8 3642.9 3750.6 3839.0 3868.0 3880.7 3898.2 3914.4 3930.6 3931.0 3932.9 3844.6 3874.1 3876.5 3880.4 3899.5 3548.6 3626.7 3676.7 3833.3 3890.0 3394.1 3395.6 3405.4 3427.6 3436.4 4822.1 4861.5 4870.9 4881.7 4884.8 4106.3 4296.3 4446.3 4451.1 4451.7 5126.4 5134.9 5143.9 5216.3 5229.9 3670.5 3672.9 3673.5 3679.7 3687.8 5348.8 5385.9 5435.5 5459.5 5479.3 3698.6 3700.5 3704.6 3707.6 3708.4 3736.9 3741.0 3752.8 3780.4 3790.5 4358.2 4367.6 4370.9 4375.5 4378.9 5107.4 5143.1 5193.8 5198.8 5255.9 1290.9 1306.6 1309.8 1311.3 1317.4 786.2 826.8 832.6 836.5 839.0 4115.7 4371.9 4421.5 4556.9 4597.6 5330.9 5341.3 5355.4 5365.4 5393.6 4539.4 4545.3 4557.0 4561.6 4568.6 2726.5 2800.9 2802.7 2805.5 2806.5 4999.0 5013.8 5014.4 5039.1 5056.5 5242.3 5393.6 5420.9 5527.2 5537.4 4956.5 4958.7 4987.6 4999.7 5020.7 5280.0 5303.9 5306.6 5313.4 5334.3 4982.7 5222.8 5231.1 5252.4 5252.5 4981.7 5004.3 5013.7 5038.6 5039.3 3667.5 3670.0 3690.2 3699.6 3704.4 5221.7 5327.6 5388.9 5391.4 5406.3 5145.0 5149.6 5152.0 5159.8 5174.1 5131.4 5136.4 5140.3 5221.9 5235.8 4925.8 5017.3 5085.5 5102.9 5112.2 4959.5 5104.6 5162.4 5187.6 5229.3 4942.7 4994.0 4994.7 4998.8 5064.8 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - PROCESS | 29326 | [#5] yui.html Cycles:180 Average:17001.39 Median:27158.30 stddev:23775.84 (87.5%) stddev-sans-first:23810.80 09:11:29 INFO - PROCESS | 29326 | Values: 640.9 650.1 655.7 656.8 666.2 12504.6 13631.9 13660.7 13665.5 13679.1 11466.8 12534.9 12563.2 12674.0 12690.2 769.1 780.2 788.3 789.6 789.8 788.2 789.2 790.0 790.1 790.2 823.3 824.5 824.8 825.2 825.5 814.7 816.9 817.2 817.4 817.7 611.3 612.3 612.6 612.7 613.1 11404.7 11412.4 11445.5 11448.1 11452.8 10813.1 10839.5 11017.7 11047.8 11148.7 9415.7 9471.5 9667.6 9671.9 9896.7 3144.3 3174.9 3187.1 3219.4 3317.6 58951.7 59880.0 60294.7 61718.4 61939.4 8213.9 8271.6 8300.2 8317.4 8328.2 16879.0 16896.2 16966.9 16971.9 17012.2 6401.2 6536.5 6784.5 6797.6 6842.5 3534.5 3601.9 3680.2 3689.9 3775.4 2925.5 2986.8 2994.3 3002.9 3005.2 482.2 494.8 499.1 501.7 503.7 604.3 608.3 630.4 637.4 642.1 8613.7 8755.4 8797.4 8862.3 8941.7 499.5 520.4 561.8 590.5 602.3 4038.8 4134.9 4228.9 4237.6 4292.6 92427.0 92575.5 92801.5 95785.0 96449.5 56010.0 69592.0 70297.3 80464.6 81694.6 70613.3 72264.0 73652.6 73698.3 74615.0 8607.8 9012.7 9015.8 9025.8 9288.3 41596.6 42574.4 42854.4 43093.6 43745.3 53796.2 58349.4 58926.4 60532.0 62428.0 11163.3 11414.0 11563.7 11646.5 11933.2 12697.4 12908.5 13152.5 13406.2 13662.9 12566.6 12738.5 13016.3 13262.9 13390.5 12142.2 12253.6 12288.1 12869.4 12914.9 11932.9 12057.0 12370.1 12375.5 12746.6 10022.6 10062.6 10522.4 10528.6 10851.8 9886.5 10860.3 10869.6 10966.1 10966.2 09:11:29 INFO - PROCESS | 29326 | -------- Summary: end -------- 09:11:29 INFO - PROCESS | 29326 | 09:11:29 INFO - TEST-INFO | 29326: exit 0 09:11:29 INFO - TEST-OK | dromaeo_css | took 1119346ms 09:11:29 INFO - TEST-START | kraken 09:11:29 INFO - operating with platform_type : linux_ 09:11:29 INFO - Initialising browser for kraken test... 09:11:29 INFO - TEST-INFO | started process 29514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HPmIi/profile http://localhost:53503/getInfo.html) 09:11:34 INFO - PROCESS | 29514 | __metrics Screen width/height:1600/1200 09:11:34 INFO - PROCESS | 29514 | colorDepth:24 09:11:34 INFO - PROCESS | 29514 | Browser inner width/height: 1024/697 09:11:34 INFO - PROCESS | 29514 | __metrics 09:11:35 INFO - PROCESS | 29514 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:11:35 INFO - PROCESS | 29514 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:35 INFO - PROCESS | 29514 | console.error: PushService: 09:11:35 INFO - PROCESS | 29514 | stateChangeProcessEnqueue: Error transitioning state 09:11:35 INFO - PROCESS | 29514 | UnknownError 09:11:35 INFO - TEST-INFO | 29514: exit 0 09:11:35 INFO - Browser initialized. 09:11:35 INFO - Running cycle 1/1 for kraken test... 09:11:35 INFO - TEST-INFO | started process 29596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HPmIi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:47 INFO - PROCESS | 29596 | RSS: Main: 157392896 09:11:47 INFO - PROCESS | 29596 | 09:11:50 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53503/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:51 INFO - PROCESS | 29596 | RSS: Main: 214298624 09:11:51 INFO - PROCESS | 29596 | 09:11:54 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53503/tests/kraken/driver.html?testName=audio-dft) 09:11:54 INFO - PROCESS | 29596 | RSS: Main: 190701568 09:11:54 INFO - PROCESS | 29596 | 09:11:58 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53503/tests/kraken/driver.html?testName=audio-fft) 09:11:58 INFO - PROCESS | 29596 | RSS: Main: 270598144 09:11:58 INFO - PROCESS | 29596 | 09:12:00 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53503/tests/kraken/driver.html?testName=audio-oscillator) 09:12:01 INFO - PROCESS | 29596 | RSS: Main: 180125696 09:12:01 INFO - PROCESS | 29596 | 09:12:03 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:04 INFO - PROCESS | 29596 | RSS: Main: 184950784 09:12:04 INFO - PROCESS | 29596 | 09:12:07 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53503/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:08 INFO - PROCESS | 29596 | RSS: Main: 220831744 09:12:08 INFO - PROCESS | 29596 | 09:12:11 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53503/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:12 INFO - PROCESS | 29596 | RSS: Main: 214687744 09:12:12 INFO - PROCESS | 29596 | 09:12:15 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53503/tests/kraken/driver.html?testName=json-parse-financial) 09:12:15 INFO - PROCESS | 29596 | RSS: Main: 218279936 09:12:15 INFO - PROCESS | 29596 | 09:12:17 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:18 INFO - PROCESS | 29596 | RSS: Main: 184389632 09:12:18 INFO - PROCESS | 29596 | 09:12:19 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:20 INFO - PROCESS | 29596 | RSS: Main: 189472768 09:12:20 INFO - PROCESS | 29596 | 09:12:22 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:23 INFO - PROCESS | 29596 | RSS: Main: 193703936 09:12:23 INFO - PROCESS | 29596 | 09:12:26 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:26 INFO - PROCESS | 29596 | RSS: Main: 188973056 09:12:26 INFO - PROCESS | 29596 | 09:12:29 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:30 INFO - PROCESS | 29596 | RSS: Main: 191774720 09:12:30 INFO - PROCESS | 29596 | 09:12:31 INFO - PROCESS | 29596 | Cycle 1(1): loaded http://localhost:53503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53503/tests/kraken/driver.html?testName=ai-astar) 09:12:32 INFO - PROCESS | 29596 | RSS: Main: 243351552 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | __start_tp_report 09:12:32 INFO - PROCESS | 29596 | _x_x_mozilla_page_load 09:12:32 INFO - PROCESS | 29596 | _x_x_mozilla_page_load_details 09:12:32 INFO - PROCESS | 29596 | |i|pagename|runs| 09:12:32 INFO - PROCESS | 29596 | |0;ai-astar;105;114;113;115;116;114;114;113;113;113 09:12:32 INFO - PROCESS | 29596 | |1;audio-beat-detection;151;129;124;188;122;125;147;128;176;128 09:12:32 INFO - PROCESS | 29596 | |2;audio-dft;161;162;161;161;162;162;162;161;163;162 09:12:32 INFO - PROCESS | 29596 | |3;audio-fft;75;76;76;120;77;76;76;76;106;77 09:12:32 INFO - PROCESS | 29596 | |4;audio-oscillator;86;85;120;85;85;84;134;84;84;136 09:12:32 INFO - PROCESS | 29596 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:12:32 INFO - PROCESS | 29596 | |6;imaging-darkroom;147;146;147;147;147;146;146;146;147;147 09:12:32 INFO - PROCESS | 29596 | |7;imaging-desaturate;94;95;94;94;95;94;95;95;95;95 09:12:32 INFO - PROCESS | 29596 | |8;json-parse-financial;63;61;61;62;66;63;61;62;61;61 09:12:32 INFO - PROCESS | 29596 | |9;json-stringify-tinderbox;64;65;65;64;67;67;66;66;66;66 09:12:32 INFO - PROCESS | 29596 | |10;stanford-crypto-aes;78;79;79;78;79;80;82;79;79;86 09:12:32 INFO - PROCESS | 29596 | |11;stanford-crypto-ccm;132;131;128;130;129;128;136;127;177;131 09:12:32 INFO - PROCESS | 29596 | |12;stanford-crypto-pbkdf2;164;164;168;160;165;164;164;166;168;168 09:12:32 INFO - PROCESS | 29596 | |13;stanford-crypto-sha256-iterative;68;69;68;68;67;66;67;66;66;71 09:12:32 INFO - PROCESS | 29596 | __end_tp_report 09:12:32 INFO - PROCESS | 29596 | __start_cc_report 09:12:32 INFO - PROCESS | 29596 | _x_x_mozilla_cycle_collect,1920 09:12:32 INFO - PROCESS | 29596 | __end_cc_report 09:12:32 INFO - PROCESS | 29596 | __startTimestamp1469895152221__endTimestamp 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | ------- Summary: start ------- 09:12:32 INFO - PROCESS | 29596 | Number of tests: 14 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 09:12:32 INFO - PROCESS | 29596 | Values: 105.0 114.0 113.0 115.0 116.0 114.0 114.0 113.0 113.0 113.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:138.00 stddev:23.46 (17.0%) stddev-sans-first:24.64 09:12:32 INFO - PROCESS | 29596 | Values: 151.0 129.0 124.0 188.0 122.0 125.0 147.0 128.0 176.0 128.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 09:12:32 INFO - PROCESS | 29596 | Values: 161.0 162.0 161.0 161.0 162.0 162.0 162.0 161.0 163.0 162.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:15.90 (20.9%) stddev-sans-first:16.57 09:12:32 INFO - PROCESS | 29596 | Values: 75.0 76.0 76.0 120.0 77.0 76.0 76.0 76.0 106.0 77.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:84.50 stddev:22.27 (26.4%) stddev-sans-first:23.17 09:12:32 INFO - PROCESS | 29596 | Values: 86.0 85.0 120.0 85.0 85.0 84.0 134.0 84.0 84.0 136.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:12:32 INFO - PROCESS | 29596 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:12:32 INFO - PROCESS | 29596 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:12:32 INFO - PROCESS | 29596 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:1.60 (2.6%) stddev-sans-first:1.66 09:12:32 INFO - PROCESS | 29596 | Values: 63.0 61.0 61.0 62.0 66.0 63.0 61.0 62.0 61.0 61.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 09:12:32 INFO - PROCESS | 29596 | Values: 64.0 65.0 65.0 64.0 67.0 67.0 66.0 66.0 66.0 66.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.42 (3.1%) stddev-sans-first:2.47 09:12:32 INFO - PROCESS | 29596 | Values: 78.0 79.0 79.0 78.0 79.0 80.0 82.0 79.0 79.0 86.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:131.00 stddev:15.01 (11.5%) stddev-sans-first:15.89 09:12:32 INFO - PROCESS | 29596 | Values: 132.0 131.0 128.0 130.0 129.0 128.0 136.0 127.0 177.0 131.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.50 stddev:2.51 (1.5%) stddev-sans-first:2.64 09:12:32 INFO - PROCESS | 29596 | Values: 164.0 164.0 168.0 160.0 165.0 164.0 164.0 166.0 168.0 168.0 09:12:32 INFO - PROCESS | 29596 | 09:12:32 INFO - PROCESS | 29596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 09:12:32 INFO - PROCESS | 29596 | Values: 68.0 69.0 68.0 68.0 67.0 66.0 67.0 66.0 66.0 71.0 09:12:32 INFO - PROCESS | 29596 | -------- Summary: end -------- 09:12:32 INFO - PROCESS | 29596 | 09:12:33 INFO - TEST-INFO | 29596: exit 0 09:12:33 INFO - TEST-OK | kraken | took 63418ms 09:12:33 INFO - SUITE-END | took 1182s 09:12:33 INFO - Completed test suite (00:19:42) 09:12:33 INFO - javascript benchmark 09:12:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.8811153498095, 2647.9470410591775, 2682.9597556036665, 2690.2601784509257, 2691.1119330620886, 4635.837745678902, 4683.508231635672, 4767.213409787381, 4899.559039686427, 4914.729689867056, 4689.976550117244, 4768.73771942543, 4774.355462012627, 4798.712077275366, 4842.443119041312, 4354.976580503587, 4370.082282720617, 4445.1331990261915, 4493.213687604656, 4553.567411095941, 4426.380306757057, 4504.0, 4518.164139634178, 4526.841560545382, 4537.4328208973875, 4311.094670119247, 4312.913741725148, 4370.628496577795, 4378.9562104378865, 4432.623227025707, 4336.3712261722185, 4385.780710964471, 4387.868363949086, 4402.955970440319, 4446.622037126848, 4435.911281774379, 4438.400815889846, 4448.065906159711, 4477.507474177838, 4489.079738653568, 4573.977130114328, 4679.74261415622, 4780.163471392527, 4873.634477414208, 4880.975595122037, 5085.440601533828, 5191.610629202825, 5191.792328306863, 5194.11700010999, 5197.610179236534, 5162.406323272834, 5176.042432150064, 5181.766820493087, 5215.556677682402, 5226.712530810804, 4636.629069674418, 4765.237561990134, 4801.111794318027, 4829.73436460998, 4853.126437241331, 5293.920591191135, 5316.3354580677415, 5353.464653534693, 5363.704996225167, 5365.08793505105, 5094.4141423736, 5097.388313402341, 5150.97424512875, 5154.252633368141, 5156.587473002151, 4983.277424773388, 5040.899182016339, 5043.722595257296, 5183.974080129575, 5233.319668443078, 5071.518205770446, 5072.239164125411, 5079.161938280143, 5103.515166059218, 5129.384473863161, 5053.84838454847, 5060.84817455477, 5065.290859279704, 5078.415982162025, 5117.488251174853, 4283.2290187765875, 4304.332828411601, 4322.37325587788, 4384.539623339567, 4423.20382331177, 3772.0569857535615, 3795.411711184771, 3838.4626152338137, 3873.748206366577, 3895.7467764595212, 4350.086481838849, 4355.390245365651, 4361.5856493633055, 4362.432883725159, 4406.537313582027, 4886.755662216875, 4937.851864444073, 5133.383993920754, 5139.537441630271, 5163.690178589297, 4347.826086956549, 4405.31717583775, 4408.625266852354, 4410.933835992462, 4474.619657329098, 4693.436787585511, 4708.4820669726305, 4711.387519622427, 4717.740524271198, 4765.9523404766205, 4591.8392856249875, 4858.95141048585, 4890.290907818347, 4913.754312284443, 4948.406191257072, 5103.897922041612, 5148.43367229612, 5158.277841102324, 5206.297149884717, 5225.973870130625, 4872.902541949212, 4884.755762211804, 4887.144749668865, 4892.510748925221, 4933.358663373739, 4831.444383895897, 5120.206368012964, 5123.001014802227, 5123.513266239701, 5125.666831655931, 5060.240963855451, 5141.151709967813, 5149.819756308511, 5195.870103247449, 5225.216217567396, 5066.4680208577565, 5082.3138876252715, 5084.41529224144, 5084.8220312288895, 5131.409887862795, 4857.805687772449, 5075.492450754895, 5078.466760990191, 5081.898362032664, 5081.932794113278, 4861.927071094007, 4875.731834749123, 4906.877328066684, 5004.0, 5006.649534532694, 5035.420926593489, 5074.31496747949, 5081.669691470042, 5084.694918304914, 5129.769160387867, 4750.976245118753, 4960.355153829979, 4967.230079337708, 4969.4782047884455, 4977.651564390458], "value": 4722.851627681534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.785381555009, 565.0958466453673, 568.7923907773659, 576.2940398012433, 583.5564970622326, 27537.173884783464, 38715.80642096789, 40277.59722402775, 40587.59412405882, 44597.55402445982, 40951.79524102383, 41276.79361603188, 41358.793206034, 41360.172796544124, 41488.0, 7383.556986580822, 7780.260875216845, 7915.8416831663335, 7924.484908480959, 7930.325922296612, 7590.316871481566, 7690.692372305101, 7699.730509432171, 9837.606495740161, 10100.898991010106, 10269.127124194452, 10321.58713651453, 10328.431936243504, 10329.070383665468, 10335.586576536929, 10141.645042423479, 10180.38917664935, 10219.029192226726, 10222.386656800616, 10229.386236825778, 10014.9499252504, 10047.899521004843, 10074.294799364048, 10080.193584513221, 10081.899181008243, 40001.59998400008, 40037.59962400368, 40376.59623403758, 40437.79781101105, 40439.98900027493, 3022.123584160591, 3043.3152540678393, 3046.8781248750024, 3169.4928811390296, 3358.3115461330367, 30351.544726829114, 30489.390212195853, 30504.54243186354, 30553.847230763702, 31874.681253187402, 3295.6045274566964, 3337.6996070353543, 3338.6661333866664, 3340.3820293245826, 3410.60778010527, 186451.0, 187017.0, 187464.0, 187742.0, 187769.0, 32005.199870003435, 54702.72648636731, 54914.72542637261, 55098.17352739632, 55156.44843551513, 32605.673943260263, 33772.831135844164, 34297.828510857784, 34312.828435857664, 34329.53716016902, 13565.864341356657, 13619.250941198132, 13672.453101875813, 13677.931610341884, 13686.178829270077, 11215.55137794479, 11281.097512199005, 11285.37930413835, 11290.943545282222, 11302.265352752045, 7358.337749602454, 7545.622718864035, 7552.546847189186, 7686.807829804299, 7778.88331675014, 3104.5964024676646, 3141.167590588496, 3150.984245078806, 3191.824449655291, 3225.9838700806813, 859.8538248497771, 885.0618344554792, 890.3900827932887, 913.488446469979, 955.9904400956041, 28456.573151402747, 28596.571051434246, 28740.137795866158, 29131.85434072816, 29304.0, 977.8435450327913, 994.2741798487145, 1026.9781567340394, 1029.5727273181546, 1043.8747350317858, 14709.264536773333, 15320.0, 15421.383144674088, 15484.92257538705, 15636.68726625484, 398899.0, 402227.0, 402897.0, 402906.0, 403160.0, 44446.55553444489, 50306.245406318936, 51105.48894511082, 51116.0, 51146.48853511491, 1175.488662431845, 1199.5201919232377, 1211.4124649544963, 1217.1236709569096, 1234.6913271682258, 28666.283342915758, 29597.26006849846, 29898.402031958805, 30511.389772203987, 30718.84640576783, 43588.56411435845, 47017.0, 48213.75893120512, 48358.758206208746, 53512.46487535231, 356855.0, 363829.0, 366713.0, 368306.0, 369834.0, 37453.4381984265, 37484.81257593694, 37556.624433756406, 37755.0, 37802.0, 40366.0, 40404.59595404008, 40604.3909341366, 40840.79579602083, 41369.0, 34372.65627343694, 34539.13652158716, 34684.0, 35251.47122793109, 35360.0, 35887.102822428606, 35992.820035899655, 36102.4584631236, 36398.8180059098, 36430.27139457249, 35319.64680353266, 35332.64667353294, 35535.46696799602, 36556.451653225755, 38674.4198837012, 32163.195920102185, 34210.65789342075, 34655.13362165966, 34778.0, 34819.0, 25600.48799023972, 25667.229983100537, 25945.740542594333, 25970.610440843026, 26041.609375859756], "value": 17213.55726521777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.24457215836503, 351.5465050085388, 359.2796443131521, 360.4881068882186, 386.25452875949424, 12864.0, 16233.756493652605, 16405.179741012947, 17482.737758933625, 17638.38265660702, 16782.244798984044, 17003.149842507886, 17215.22531486083, 17368.305267789274, 17473.91263043683, 4994.200927851544, 5050.318207042057, 5133.435322114565, 5153.252778347138, 5159.380874295071, 3763.5671897731836, 5089.796408143669, 5180.740962951837, 5701.543876489871, 6001.759929602833, 6013.1581578579035, 6026.728797204114, 6037.184980027706, 6039.667818269993, 6041.546883983697, 5186.455422180673, 5435.211894275308, 5458.2904222451225, 5500.3949565547755, 6028.4574388305045, 5289.629725919187, 5320.733963301819, 5361.5978801589645, 5364.6512976656395, 5368.141097424394, 11800.055995520337, 11926.0, 11957.701057473545, 12043.156979011474, 12135.271883687006, 1841.0518582929801, 1932.3526618582791, 2026.2604149485478, 2069.2550681754556, 2266.8665667166415, 8986.731302631264, 9430.764230894214, 9474.194693451065, 10593.78812423755, 12047.879521204763, 1708.2654458582804, 1748.7376893465955, 1752.956176095595, 1760.6566719489704, 1791.5073354827528, 67304.66347668279, 69719.30280697178, 69865.3013469864, 70597.64701176513, 71727.64136179286, 9995.500224988722, 10156.593736250616, 10206.081452669296, 10401.167906567607, 10844.078253348396, 13774.724505509834, 13797.172169669851, 13800.171989680652, 13825.723485530434, 13826.101303415246, 6973.93026069743, 7177.856442871113, 7187.281271872876, 7251.456140789462, 7355.080614923135, 6770.221424536241, 6796.592204467748, 6934.341237582422, 6954.269801670752, 7069.187043489962, 4204.159168166379, 4242.893927651771, 4307.913841723148, 4367.519572846984, 4410.713303635253, 1798.9280428782963, 1840.0983518076046, 1841.6500864835907, 1851.6389304085844, 1884.8303652671325, 693.6393075600761, 808.9919100809034, 915.2997956563235, 926.1710768861831, 933.0016881936399, 16431.26059327333, 16685.49943501697, 17211.827881721274, 17346.132693365533, 17676.381326653507, 866.8526350520426, 870.9433886797337, 925.9583318750672, 947.2280091725222, 953.8903026151943, 7016.649167541603, 9292.766029622415, 9728.367656102331, 9877.654282100235, 9886.0, 383459.33081338217, 388681.0, 402464.0, 402866.0, 404927.0, 55803.72098139564, 76941.0, 77905.0, 78080.60959695165, 80682.59658701786, 855.5465603230298, 864.4935903129244, 874.2481465939287, 883.8497455432592, 884.9557522123868, 15254.389824406899, 15460.304286306919, 15567.221638917783, 15937.442189523312, 15966.760498592297, 36299.27401451903, 36865.815670921475, 36918.815405922796, 37121.81439092895, 37414.99999999891, 46652.7667361661, 49995.0, 51126.0, 52167.73916130395, 52840.20739688985, 6011.008183649649, 6341.460975817107, 7657.961710191414, 7769.494982826098, 7894.723684671009, 9693.9030609693, 10609.575616975235, 11417.60038398652, 11744.119191060534, 11830.822537662114, 6194.38056194377, 9319.440833550008, 9447.716568502956, 9547.522623868917, 9593.712188634352, 9446.858297125686, 9513.90486095158, 9836.901630983599, 9873.210143188671, 10261.897381026094, 9479.336446448959, 9502.144806967406, 9913.45475998827, 9981.301308908307, 10315.071643552117, 7340.339369456561, 7492.51298665585, 7514.8872766909635, 7517.0, 7750.759878419426, 8382.622781974947, 9602.231821454126, 9645.37305075168, 9934.304598678023, 10215.846762298721], "value": 8013.903402881789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.8765311121997, 1400.0829456705858, 1460.9415623375066, 1663.2432243329285, 1704.5823773175566, 7093.680784364703, 7524.473286869921, 7527.510711803736, 7530.209328020561, 7534.321911028, 6233.283172435172, 6969.19854216764, 7146.74986375477, 7196.424286057116, 7356.816079598013, 2125.3836387447623, 2153.12798316682, 2157.611629906616, 2157.6763485477145, 2160.9351719448364, 2143.47484866208, 2164.891755412223, 2183.759786423492, 2187.059564387313, 2187.7155969723913, 2148.4414052346347, 2149.419656692692, 2169.0889826273005, 2169.3708824440973, 2175.042981088324, 2107.620628286908, 2111.5882402931434, 2113.144176608476, 2114.270576651053, 2114.925977590792, 2038.6840039793856, 2090.9790902090936, 2092.6502405948077, 2092.79072092791, 2094.5077906691913, 7216.855662886713, 7316.890246646304, 7337.669804858794, 7351.926480735231, 7357.484976051678, 4406.162829062468, 4485.170243504962, 4506.797194126272, 4516.480604730433, 4521.412216411878, 2628.5531459651907, 2738.6165936768866, 2820.3936153727045, 2842.2752198189537, 2844.1467559732205, 855.234565064264, 896.0412358776113, 896.5741272895388, 899.2895612466144, 904.4980036079972, 9792.412455252708, 9835.950820245924, 9837.016298370107, 9840.065193806577, 9861.260405469618, 3868.3810590305416, 3934.272159650474, 4092.7748973806133, 4127.174565086934, 4163.375493675972, 8506.872396914052, 8546.0, 8556.871646925301, 8568.528730919734, 8571.0, 4516.096780643885, 4520.050789334211, 4525.411696479437, 4533.977330113328, 4539.16025535277, 3622.0763705255517, 3893.124047089382, 4013.7190396671954, 4160.188763191149, 4163.604457576525, 3543.94684079739, 3549.1304630365207, 3665.2303016366327, 3668.559772827278, 3781.4516895050615, 1167.486306025346, 1189.1378750405886, 1204.9819252711216, 1208.2206976500108, 1217.9695507612203, 852.1606217875387, 856.7760938572895, 870.425519157353, 883.4743327719997, 909.231699214163, 4980.8256711015665, 5073.822416215488, 5143.099957507421, 5155.0, 5189.065968125774, 415.36034506859704, 417.3135192608203, 417.39060970982706, 421.9662427005832, 424.0458967323522, 3569.464580312974, 3651.835667394974, 3692.4276737105793, 3697.186618943828, 3772.1512659651908, 8763.56182190888, 9062.773430664287, 9192.356535042616, 9198.77003074915, 9198.908010919806, 9140.63437462494, 9161.312901532412, 9166.450012999108, 9168.129027742354, 9173.541322933826, 6567.1462709848365, 6738.258791532928, 6906.861862762717, 7022.192447868459, 7052.858942821217, 5300.31095957523, 5399.946000539944, 5400.702961337164, 5411.621186516906, 5611.691356975405, 8207.425480216327, 8256.628451719807, 8259.752207433787, 8317.625706843086, 8396.538190399586, 8137.837243254983, 8328.875066873881, 8408.201220884006, 8468.110848360833, 8526.062133165471, 5741.1388291756575, 6316.684165791784, 6617.702203400955, 6771.898421523582, 6778.661066946534, 7010.193827709879, 7178.102737157856, 7221.350078492751, 7225.24134965821, 7231.8553628928175, 6395.0, 6422.229332480132, 6476.384743449365, 6485.481161506974, 6601.33986601336, 6311.211098612674, 6316.147320111726, 6400.135981642418, 6414.486841052611, 6442.967785161044, 5904.852378690567, 5993.220881285405, 5997.640141591519, 5997.700114994145, 6002.549808764273, 4350.71720338177, 4378.562143785596, 4385.320275357325, 4461.977690111528, 4571.49713531518, 4224.640905522942, 4405.40527028847, 4469.821207151677, 4474.37358769766, 4497.617702495194], "value": 3930.4502607982895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.0762575873857, 284.8960129552713, 286.7419322609651, 296.8678937872646, 298.7893535057784, 4946.554810067093, 4956.776945037473, 4997.450280469146, 4999.07517109335, 5007.399112106547, 4897.649128418352, 4901.852944411665, 4914.262860570916, 4960.900781984358, 4996.800127994885, 3642.872499462526, 3750.6061863504347, 3838.9808050959846, 3868.0, 3880.670143037831, 3898.200868821899, 3914.4128380742973, 3930.5630509084267, 3931.036895960494, 3932.8959006931295, 3844.5770965193806, 3874.128321127752, 3876.476675648794, 3880.3597406427907, 3899.473571067912, 3548.6273941236313, 3626.6554677305744, 3676.724245681558, 3833.3291673956946, 3890.0469385000715, 3394.100563350714, 3395.558577384949, 3405.387030334539, 3427.5544179256785, 3436.350551735181, 4822.083804077214, 4861.489543597907, 4870.879697669556, 4881.730750004989, 4884.803223210336, 4106.342985122366, 4296.312589985588, 4446.333050042519, 4451.109778044404, 4451.666125040602, 5126.41116236302, 5134.919048570865, 5143.871403214912, 5216.347956505437, 5229.869253268661, 3670.5228320318456, 3672.8530858765616, 3673.485712000322, 3679.7240206984584, 3687.815609219555, 5348.786048558053, 5385.892282154335, 5435.456454354572, 5459.454054594548, 5479.287692599976, 3698.6315063426705, 3700.4634328022285, 3704.5554533456157, 3707.629237076271, 3708.3695771718335, 3736.860257621397, 3741.0, 3752.774833509998, 3780.432935059708, 3790.488284081669, 4358.193734159191, 4367.563243675607, 4370.890727731832, 4375.496817865923, 4378.890527736832, 5107.361579802525, 5143.12566863634, 5193.818216362409, 5198.792048318025, 5255.947440525546, 1290.9354532273348, 1306.6276111308232, 1309.8035294705871, 1311.344327836082, 1317.4071667749552, 786.2294950948103, 826.8263664630375, 832.629479881459, 836.4981011393115, 838.995805020971, 4115.71190016696, 4371.912561748747, 4421.53573874745, 4556.931646025312, 4597.551900997262, 5330.92003619946, 5341.252224688546, 5355.437679043722, 5365.382980957162, 5393.568514518829, 4539.387182730289, 4545.318202269686, 4557.0, 4561.589456948891, 4568.634509239253, 2726.5413004042744, 2800.8599570021415, 2802.7337402946687, 2805.5370863807652, 2806.466771313444, 4998.975005124951, 5013.774380152902, 5014.373203349582, 5039.135519857676, 5056.494350564914, 5242.318498595158, 5393.568514518829, 5420.945790542123, 5527.226188333637, 5537.363203231599, 4956.479569645279, 4958.6776859504735, 4987.600991920638, 4999.675086102186, 5020.698758074454, 5280.049591073644, 5303.946960530346, 5306.575473962151, 5313.3889602694635, 5334.253204551288, 4982.65815066918, 5222.843314700413, 5231.136862417658, 5252.448492908343, 5252.501012403815, 4981.701097934136, 5004.274380214775, 5013.674111182761, 5038.596912246938, 5039.344885165052, 3667.541557305337, 3669.9633003669624, 3690.1881586051027, 3699.6300369963865, 3704.388775851954, 5221.738913054256, 5327.573794096385, 5388.865278368072, 5391.409534187345, 5406.324209473816, 5144.964470962151, 5149.58386443716, 5151.974240128776, 5159.832870194602, 5174.14626586609, 5131.384233891957, 5136.357955255593, 5140.30605868203, 5221.869453263547, 5235.842924712265, 4925.827596034122, 5017.272495488207, 5085.4914508548845, 5102.923456148086, 5112.182050871843, 4959.479254678206, 5104.591632669451, 5162.380514338303, 5187.636865419385, 5229.346331708536, 4942.728149951643, 4993.950060499348, 4994.675346102492, 4998.825041123543, 5064.848054558369], "value": 3873.279725426117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.8539428390027, 650.1353200243676, 655.7475371981787, 656.7996760987896, 666.1941182593698, 12504.56234031809, 13631.863681363184, 13660.658483537916, 13665.521706740266, 13679.110857794261, 11466.770664586704, 12534.937325313384, 12563.246205227693, 12673.986081113511, 12690.238585684865, 769.0771074710342, 780.1769133564088, 788.3338578900848, 789.6367670871406, 789.7986013566561, 788.1606089514677, 789.2265579731866, 790.0, 790.1032328307355, 790.1624278265028, 823.2508417340222, 824.4558591329724, 824.7773101262655, 825.1995564302647, 825.529448214518, 814.7392834293029, 816.873384625384, 817.2195553246635, 817.4441379861692, 817.6811043692965, 611.2634275697774, 612.3386742318286, 612.5558969746943, 612.7212118486078, 613.1446631948452, 11404.714882128013, 11412.42937853104, 11445.484953177043, 11448.084153267719, 11452.828207576893, 10813.08088812452, 10839.458027098692, 11017.669469915916, 11047.83428248577, 11148.665540033811, 9415.668276012771, 9471.526423678788, 9667.564959576766, 9671.90328096717, 9896.653617123438, 3144.2768163322335, 3174.9047528573947, 3187.123541026213, 3219.356128774231, 3317.5853018372704, 58951.705241473945, 59880.0, 60294.69852650753, 61718.38281617171, 61939.38060619426, 8213.876791848126, 8271.586420678943, 8300.2114799094, 8317.376196785266, 8328.167183281623, 16879.0, 16896.239669214916, 16966.91516542434, 16971.91514042422, 17012.234449449803, 6401.167848179707, 6536.509761767887, 6784.525083244125, 6797.5581587196675, 6842.516588597785, 3534.5228394166975, 3601.9279614407565, 3680.227152297994, 3689.9077523062138, 3775.3959366501226, 2925.517289647227, 2986.77599180058, 2994.2813724705916, 3002.894898678536, 3005.233665415305, 482.2115840600643, 494.8094983431405, 499.1439680947193, 501.70900877490965, 503.68519675203, 604.3412680178538, 608.2913405882186, 630.3790766095392, 637.4263163153106, 642.1491523731075, 8613.741587752378, 8755.387122901337, 8797.38418310712, 8862.291016718777, 8941.721434793004, 499.4580879745444, 520.4093354043189, 561.8230257468884, 590.5275779376482, 602.256213576233, 4038.7778672172726, 4134.937975930364, 4228.936565951513, 4237.618614324664, 4292.613664770186, 92427.0, 92575.5371223153, 92801.53599231961, 95785.0, 96449.51775241079, 56010.0, 69592.0, 70297.2970270301, 80464.59767701125, 81694.59152704198, 70613.2938670617, 72264.0, 73652.63173684204, 73698.2630173702, 74615.0, 8607.827843443221, 9012.684556040507, 9015.77460563465, 9025.81948361016, 9288.256939444964, 41596.58403415927, 42574.36138457864, 42854.35718464288, 43093.569064308955, 43745.34381984209, 53796.19305710496, 58349.416505836096, 58926.410735892096, 60532.0, 62428.0, 11163.330200188015, 11414.0, 11563.6530904073, 11646.534138634699, 11933.164678472423, 12697.42861571213, 12908.483660653468, 13152.539661111816, 13406.195628262336, 13662.863371366158, 12566.560170393992, 12738.490460381481, 13016.349182540645, 13262.867371326163, 13390.464381424634, 12142.150049496451, 12253.576532568595, 12288.1398302118, 12869.420876060787, 12914.935425322814, 11932.880671193177, 12057.0, 12370.072244581872, 12375.504979800708, 12746.553870614483, 10022.599096036078, 10062.647807326708, 10522.421266830397, 10528.631497897843, 10851.782964340828, 9886.50567471638, 10860.294080884718, 10869.619563315562, 10966.067884229611, 10966.17753668494], "value": 6474.599291068434, "unit": "score"}], "name": "dromaeo_css", "value": 6328.251513515107, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 115.0, 116.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 124.0, 188.0, 122.0, 125.0, 147.0, 128.0, 176.0, 128.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 120.0, 77.0, 76.0, 76.0, 76.0, 106.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 120.0, 85.0, 85.0, 84.0, 134.0, 84.0, 84.0, 136.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 66.0, 63.0, 61.0, 62.0, 61.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 79.0, 80.0, 82.0, 79.0, 79.0, 86.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 128.0, 130.0, 129.0, 128.0, 136.0, 127.0, 177.0, 131.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 168.0, 160.0, 165.0, 164.0, 164.0, 166.0, 168.0, 168.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 71.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1531.7, "alertThreshold": 2.0}]} 09:12:33 INFO - Return code: 0 09:12:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:33 INFO - # TBPL SUCCESS # 09:12:33 INFO - Running post-action listener: _resource_record_post_action 09:12:33 INFO - [mozharness: 2016-07-30 16:12:33.513523Z] Finished run-tests step (success) 09:12:33 INFO - Running post-run listener: _resource_record_post_run 09:12:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528211968; Read time: 36; Write time: 420056 09:12:33 INFO - TinderboxPrint: CPU usage
13.0% 09:12:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 09:12:33 INFO - TinderboxPrint: I/O write bytes / time
528,211,968 / 420,056 09:12:33 INFO - TinderboxPrint: CPU idle
8,325.0 (87.0%) 09:12:33 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 09:12:33 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244031488; Read time: 0; Write time: 198368 09:12:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284180480; Read time: 36; Write time: 221688 09:12:34 INFO - Running post-run listener: _upload_blobber_files 09:12:34 INFO - Blob upload gear active. 09:12:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:38 INFO - (blobuploader) - INFO - Done attempting. 09:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:12:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:38 INFO - (blobuploader) - INFO - Done attempting. 09:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:39 INFO - (blobuploader) - INFO - Done attempting. 09:12:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:39 INFO - Return code: 0 09:12:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e67efef810627b99f277409c7a1fcd77a1141903b5ff4fa8795290a7fda78dcd6e0c2b4ede03e4883cf3130c7cc67a76e87592cd7ff227321f259c0861b9a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9834de5c6350c79e5fc5930df5e7e407eaf0a0e247d7e3d0140aca6ac690282939108cb463b889ca674629634fc4eea8a1f90733dbf5d958c542053a966a49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7f9d3340cab854614280e9d0a12f014edca97a86218204a8b94bae0d467c102b4393e5aa50f2e10456bb33a87976387e57f45eb87b2dacce221514d3d704f51"} 09:12:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:39 INFO - Contents: 09:12:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e67efef810627b99f277409c7a1fcd77a1141903b5ff4fa8795290a7fda78dcd6e0c2b4ede03e4883cf3130c7cc67a76e87592cd7ff227321f259c0861b9a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9834de5c6350c79e5fc5930df5e7e407eaf0a0e247d7e3d0140aca6ac690282939108cb463b889ca674629634fc4eea8a1f90733dbf5d958c542053a966a49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7f9d3340cab854614280e9d0a12f014edca97a86218204a8b94bae0d467c102b4393e5aa50f2e10456bb33a87976387e57f45eb87b2dacce221514d3d704f51"} 09:12:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:39 INFO - Copying logs to upload dir... 09:12:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.009052 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-30 09:12:39.272144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:12:39.275654) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e67efef810627b99f277409c7a1fcd77a1141903b5ff4fa8795290a7fda78dcd6e0c2b4ede03e4883cf3130c7cc67a76e87592cd7ff227321f259c0861b9a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9834de5c6350c79e5fc5930df5e7e407eaf0a0e247d7e3d0140aca6ac690282939108cb463b889ca674629634fc4eea8a1f90733dbf5d958c542053a966a49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7f9d3340cab854614280e9d0a12f014edca97a86218204a8b94bae0d467c102b4393e5aa50f2e10456bb33a87976387e57f45eb87b2dacce221514d3d704f51"} build_url:https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/Rd3uUoFjRN6NtrBlymu-Aw/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-Non-PGO/sha512/5e67efef810627b99f277409c7a1fcd77a1141903b5ff4fa8795290a7fda78dcd6e0c2b4ede03e4883cf3130c7cc67a76e87592cd7ff227321f259c0861b9a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9834de5c6350c79e5fc5930df5e7e407eaf0a0e247d7e3d0140aca6ac690282939108cb463b889ca674629634fc4eea8a1f90733dbf5d958c542053a966a49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7f9d3340cab854614280e9d0a12f014edca97a86218204a8b94bae0d467c102b4393e5aa50f2e10456bb33a87976387e57f45eb87b2dacce221514d3d704f51"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:12:39.301821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:12:39.302160) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469893872.192844-1355975088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:12:39.387682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:12:39.388024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:12:39.388357) ========= ========= Total master_lag: 0.18 =========