builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1469794600.34 results: success (0) buildid: 20160729040124 builduid: 5f70039e5cf042229f7a78833aa094af revision: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.344034) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.344502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.344775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.374101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.374626) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 05:16:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2016-07-29 05:16:40 (105 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.544697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.545002) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063516 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.619711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:40.620055) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c --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 f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c --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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 05:16:40,863 truncating revision to first 12 chars 2016-07-29 05:16:40,863 Setting DEBUG logging. 2016-07-29 05:16:40,863 attempt 1/10 2016-07-29 05:16:40,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5f1c014ca19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 05:16:41,165 unpacking tar archive at: fx-team-f5f1c014ca19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:41.258664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:41.258990) ========= script_repo_revision: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:41.259398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:41.259662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 05:16:41.269529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-29 05:16:41.269896) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:41 INFO - MultiFileLogger online at 20160729 05:16:41 in /builds/slave/test 05:16:41 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 05:16:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:41 INFO - {'append_to_log': False, 05:16:41 INFO - 'base_work_dir': '/builds/slave/test', 05:16:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:16:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:41 INFO - 'branch': 'Fx-Team-Non-PGO', 05:16:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:41 INFO - 'config_files': ('talos/linux_config.py',), 05:16:41 INFO - 'default_actions': ('clobber', 05:16:41 INFO - 'read-buildbot-config', 05:16:41 INFO - 'download-and-extract', 05:16:41 INFO - 'populate-webroot', 05:16:41 INFO - 'create-virtualenv', 05:16:41 INFO - 'install', 05:16:41 INFO - 'run-tests'), 05:16:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:41 INFO - 'download_minidump_stackwalk': True, 05:16:41 INFO - 'download_symbols': 'ondemand', 05:16:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:41 INFO - 'installer_path': 'installer.exe', 05:16:41 INFO - 'log_level': 'info', 05:16:41 INFO - 'log_name': 'talos', 05:16:41 INFO - 'log_to_console': True, 05:16:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:41 INFO - 'opt_config_files': (), 05:16:41 INFO - 'pip_index': False, 05:16:41 INFO - 'sps_profile': False, 05:16:41 INFO - 'sps_profile_interval': 0, 05:16:41 INFO - 'suite': 'dromaeojs', 05:16:41 INFO - 'system_bits': '32', 05:16:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:41 INFO - 'title': 'talos-linux64-ix-013', 05:16:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:41 INFO - 'use_talos_json': True, 05:16:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:41 INFO - 'work_dir': 'build'} 05:16:41 INFO - [mozharness: 2016-07-29 12:16:41.732429Z] Running clobber step. 05:16:41 INFO - Running pre-action listener: _resource_record_pre_action 05:16:41 INFO - Running main action method: clobber 05:16:41 INFO - rmtree: /builds/slave/test/build 05:16:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - [mozharness: 2016-07-29 12:16:43.723382Z] Finished clobber step (success) 05:16:43 INFO - [mozharness: 2016-07-29 12:16:43.723604Z] Running read-buildbot-config step. 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: read_buildbot_config 05:16:43 INFO - Using buildbot properties: 05:16:43 INFO - { 05:16:43 INFO - "project": "", 05:16:43 INFO - "product": "firefox", 05:16:43 INFO - "script_repo_revision": "production", 05:16:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:16:43 INFO - "repository": "", 05:16:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:16:43 INFO - "buildid": "20160729040124", 05:16:43 INFO - "pgo_build": "False", 05:16:43 INFO - "basedir": "/builds/slave/test", 05:16:43 INFO - "buildnumber": 2040, 05:16:43 INFO - "slavename": "talos-linux64-ix-013", 05:16:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:16:43 INFO - "platform": "ubuntu64_hw", 05:16:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:16:43 INFO - "branch": "fx-team", 05:16:43 INFO - "repo_path": "integration/fx-team", 05:16:43 INFO - "revision": "f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c", 05:16:43 INFO - "stage_platform": "linux64", 05:16:43 INFO - "builduid": "5f70039e5cf042229f7a78833aa094af", 05:16:43 INFO - "slavebuilddir": "test" 05:16:43 INFO - } 05:16:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - [mozharness: 2016-07-29 12:16:43.727292Z] Finished read-buildbot-config step (success) 05:16:43 INFO - [mozharness: 2016-07-29 12:16:43.727392Z] Running download-and-extract step. 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: download_and_extract 05:16:43 INFO - mkdir: /builds/slave/test/build/tests 05:16:43 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')]} 05:16:43 INFO - https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:44 INFO - Downloaded 1361 bytes. 05:16:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:44 INFO - Using the following test package requirements: 05:16:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'jsshell-linux-x86_64.zip'], 05:16:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:44 INFO - https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:45 INFO - Downloaded 20231869 bytes. 05:16:45 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'] 05:16:45 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 05:16:46 INFO - Return code: 0 05:16:46 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 05:16:46 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')]} 05:16:46 INFO - https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:47 INFO - Downloaded 20231869 bytes. 05:16:47 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'] 05:16:47 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 05:16:49 INFO - Return code: 0 05:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:50 INFO - Downloaded 14413725 bytes. 05:16:50 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'] 05:16:50 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 05:16:50 INFO - Return code: 0 05:16: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')]} 05:16:50 INFO - https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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 05:16:51 INFO - Downloaded 55585509 bytes. 05:16:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:51 INFO - mkdir: /builds/slave/test/properties 05:16:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:51 INFO - Contents: 05:16:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:52 INFO - Running post-action listener: _resource_record_post_action 05:16:52 INFO - Running post-action listener: set_extra_try_arguments 05:16:52 INFO - [mozharness: 2016-07-29 12:16:52.546033Z] Finished download-and-extract step (success) 05:16:52 INFO - [mozharness: 2016-07-29 12:16:52.546265Z] Running populate-webroot step. 05:16:52 INFO - Running pre-action listener: _resource_record_pre_action 05:16:52 INFO - Running main action method: populate_webroot 05:16:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:52 INFO - '--tppagecycles', 05:16:52 INFO - '7'], 05:16:52 INFO - 'tests': ['tsvgm']}}, 05:16:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['damp', 'tps']}, 05:16:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'tests': ['damp', 'tps']}, 05:16:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['dromaeo_dom']}, 05:16:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['basic_compositor_video']}, 05:16:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['a11yr', 05:16:52 INFO - 'ts_paint', 05:16:52 INFO - 'tpaint', 05:16:52 INFO - 'sessionrestore', 05:16:52 INFO - 'sessionrestore_no_auto_restore', 05:16:52 INFO - 'tabpaint']}, 05:16:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['tsvgx', 05:16:52 INFO - 'tsvgr_opacity', 05:16:52 INFO - 'tart', 05:16:52 INFO - 'tscrollx', 05:16:52 INFO - 'cart']}, 05:16:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:52 INFO - 'tsvgr_opacity', 05:16:52 INFO - 'tart', 05:16:52 INFO - 'tscrollx', 05:16:52 INFO - 'cart']}, 05:16:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'talos_options': ['--disable-e10s'], 05:16:52 INFO - 'tests': ['tp5o']}, 05:16:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'tests': ['tp5o']}, 05:16:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'talos_options': ['--disable-e10s', 05:16:52 INFO - '--xperf_path', 05:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:52 INFO - 'tests': ['tp5n']}, 05:16:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:52 INFO - 'talos_options': ['--xperf_path', 05:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:52 INFO - 'tests': ['tp5n']}}, 05:16:52 INFO - 'talos.zip': {'path': '', 05:16:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:52 INFO - Running post-action listener: _resource_record_post_action 05:16:52 INFO - [mozharness: 2016-07-29 12:16:52.564083Z] Finished populate-webroot step (success) 05:16:52 INFO - [mozharness: 2016-07-29 12:16:52.564172Z] Running create-virtualenv step. 05:16:52 INFO - Running pre-action listener: _resource_record_pre_action 05:16:52 INFO - Running main action method: create_virtualenv 05:16:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:52 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 05:16:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:52 INFO - Using real prefix '/usr' 05:16:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:59 INFO - Installing pip.................done. 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:59 INFO - Using env: {'DISPLAY': ':0', 05:16:59 INFO - 'HOME': '/home/cltbld', 05:16:59 INFO - 'LANG': 'en_US.UTF-8', 05:16:59 INFO - 'LANGUAGE': 'en_US:en', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MAIL': '/var/mail/cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SHLVL': '1', 05:16:59 INFO - 'TERM': 'linux', 05:16:59 INFO - 'TMOUT': '86400', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - '_': '/tools/buildbot/bin/python'} 05:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:00 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 05:17:00 INFO - Cleaning up... 05:17:00 INFO - Return code: 0 05:17:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:00 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 05:17:00 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 05:17:00 INFO - Using env: {'DISPLAY': ':0', 05:17:00 INFO - 'HOME': '/home/cltbld', 05:17:00 INFO - 'LANG': 'en_US.UTF-8', 05:17:00 INFO - 'LANGUAGE': 'en_US:en', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MAIL': '/var/mail/cltbld', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SHLVL': '1', 05:17:00 INFO - 'TERM': 'linux', 05:17:00 INFO - 'TMOUT': '86400', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - '_': '/tools/buildbot/bin/python'} 05:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:00 INFO - Downloading/unpacking psutil>=3.1.1 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:00 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 05:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:02 INFO - Installing collected packages: psutil 05:17:02 INFO - Running setup.py install for psutil 05:17:02 INFO - building 'psutil._psutil_linux' extension 05:17:02 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 05:17:03 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 05:17:03 INFO - building 'psutil._psutil_posix' extension 05:17:03 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 05:17:03 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 05:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:03 INFO - Successfully installed psutil 05:17:03 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:04 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 05:17:04 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 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:04 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 05:17:04 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 05:17:04 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 05:17:04 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 05:17:04 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 05:17:04 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 05:17:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:06 INFO - Installing collected packages: mozsystemmonitor 05:17:06 INFO - Running setup.py install for mozsystemmonitor 05:17:06 INFO - Successfully installed mozsystemmonitor 05:17:06 INFO - Cleaning up... 05:17:06 INFO - Return code: 0 05:17:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:06 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')]} 05:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 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')]} 05:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:06 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 05:17:06 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 05:17:06 INFO - Using env: {'DISPLAY': ':0', 05:17:06 INFO - 'HOME': '/home/cltbld', 05:17:06 INFO - 'LANG': 'en_US.UTF-8', 05:17:06 INFO - 'LANGUAGE': 'en_US:en', 05:17:06 INFO - 'LOGNAME': 'cltbld', 05:17:06 INFO - 'MAIL': '/var/mail/cltbld', 05:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:06 INFO - 'MOZ_NO_REMOTE': '1', 05:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:06 INFO - 'NO_EM_RESTART': '1', 05:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:06 INFO - 'PWD': '/builds/slave/test', 05:17:06 INFO - 'SHELL': '/bin/bash', 05:17:06 INFO - 'SHLVL': '1', 05:17:06 INFO - 'TERM': 'linux', 05:17:06 INFO - 'TMOUT': '86400', 05:17:06 INFO - 'USER': 'cltbld', 05:17:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:06 INFO - '_': '/tools/buildbot/bin/python'} 05:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:06 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 05:17:06 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 05:17:06 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 05:17:06 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 05:17:06 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 05:17:06 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 05:17:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 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 05:17:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:08 INFO - warning: no files found matching '*.txt' 05:17:08 INFO - no previously-included directories found matching 'build' 05:17:08 INFO - no previously-included directories found matching 'dist' 05:17:08 INFO - no previously-included directories found matching '.git*' 05:17:08 INFO - Installing collected packages: jsonschema, functools32 05:17:08 INFO - Running setup.py install for functools32 05:17:08 INFO - warning: no files found matching '*.txt' 05:17:08 INFO - no previously-included directories found matching 'build' 05:17:08 INFO - no previously-included directories found matching 'dist' 05:17:08 INFO - no previously-included directories found matching '.git*' 05:17:08 INFO - Successfully installed jsonschema functools32 05:17:08 INFO - Cleaning up... 05:17:08 INFO - Return code: 0 05:17:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:08 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 05:17:08 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 05:17:08 INFO - Using env: {'DISPLAY': ':0', 05:17:08 INFO - 'HOME': '/home/cltbld', 05:17:08 INFO - 'LANG': 'en_US.UTF-8', 05:17:08 INFO - 'LANGUAGE': 'en_US:en', 05:17:08 INFO - 'LOGNAME': 'cltbld', 05:17:08 INFO - 'MAIL': '/var/mail/cltbld', 05:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:08 INFO - 'MOZ_NO_REMOTE': '1', 05:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:08 INFO - 'NO_EM_RESTART': '1', 05:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:08 INFO - 'PWD': '/builds/slave/test', 05:17:08 INFO - 'SHELL': '/bin/bash', 05:17:08 INFO - 'SHLVL': '1', 05:17:08 INFO - 'TERM': 'linux', 05:17:08 INFO - 'TMOUT': '86400', 05:17:08 INFO - 'USER': 'cltbld', 05:17:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:08 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:09 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 05:17:09 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 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:09 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 05:17:09 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 05:17:09 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 05:17:09 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 05:17:09 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 05:17:09 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 05:17:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 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 05:17:11 INFO - Downloading docopt-0.6.1.tar.gz 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:11 INFO - Running setup.py install for blobuploader 05:17:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:12 INFO - Running setup.py install for requests 05:17:12 INFO - Running setup.py install for docopt 05:17:12 INFO - Successfully installed blobuploader requests docopt 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:12 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 05:17:12 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 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:12 INFO - Running setup.py (path:/tmp/pip-Wx6Unf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:12 INFO - Running setup.py (path:/tmp/pip-L88_q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:12 INFO - Running setup.py (path:/tmp/pip-17yGFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:12 INFO - Running setup.py (path:/tmp/pip-pxthrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:13 INFO - Running setup.py (path:/tmp/pip-OfDM6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:13 INFO - Running setup.py (path:/tmp/pip-NIQmQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:13 INFO - Running setup.py (path:/tmp/pip-FOQx1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:13 INFO - Running setup.py (path:/tmp/pip-F7WCeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:13 INFO - Running setup.py (path:/tmp/pip-hhaFfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:13 INFO - Running setup.py (path:/tmp/pip-GBWEQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:13 INFO - Running setup.py (path:/tmp/pip-xkaaZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:13 INFO - Running setup.py (path:/tmp/pip-o7FA37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:13 INFO - Running setup.py (path:/tmp/pip-YTEil_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:13 INFO - Running setup.py (path:/tmp/pip-Q_9mTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:13 INFO - Running setup.py (path:/tmp/pip-FR73_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:13 INFO - Running setup.py (path:/tmp/pip-gfw11b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:13 INFO - Running setup.py (path:/tmp/pip-fR26WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:14 INFO - Running setup.py install for manifestparser 05:17:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Running setup.py install for mozcrash 05:17:14 INFO - Running setup.py install for mozdebug 05:17:14 INFO - Running setup.py install for mozdevice 05:17:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Running setup.py install for mozfile 05:17:14 INFO - Running setup.py install for mozhttpd 05:17:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Running setup.py install for mozinfo 05:17:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Running setup.py install for mozInstall 05:17:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:14 INFO - Running setup.py install for mozleak 05:17:14 INFO - Running setup.py install for mozlog 05:17:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Running setup.py install for moznetwork 05:17:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Running setup.py install for mozprocess 05:17:15 INFO - Running setup.py install for mozprofile 05:17:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Running setup.py install for mozrunner 05:17:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Running setup.py install for mozscreenshot 05:17:15 INFO - Running setup.py install for moztest 05:17:15 INFO - Running setup.py install for mozversion 05:17:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:15 INFO - Cleaning up... 05:17:15 INFO - Return code: 0 05:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:15 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:15 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 05:17:15 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 05:17:15 INFO - Using env: {'DISPLAY': ':0', 05:17:15 INFO - 'HOME': '/home/cltbld', 05:17:15 INFO - 'LANG': 'en_US.UTF-8', 05:17:15 INFO - 'LANGUAGE': 'en_US:en', 05:17:15 INFO - 'LOGNAME': 'cltbld', 05:17:15 INFO - 'MAIL': '/var/mail/cltbld', 05:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:15 INFO - 'MOZ_NO_REMOTE': '1', 05:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:15 INFO - 'NO_EM_RESTART': '1', 05:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:15 INFO - 'PWD': '/builds/slave/test', 05:17:15 INFO - 'SHELL': '/bin/bash', 05:17:15 INFO - 'SHLVL': '1', 05:17:15 INFO - 'TERM': 'linux', 05:17:15 INFO - 'TMOUT': '86400', 05:17:15 INFO - 'USER': 'cltbld', 05:17:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:15 INFO - '_': '/tools/buildbot/bin/python'} 05:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:16 INFO - Running setup.py (path:/tmp/pip-Q7p92f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:16 INFO - Running setup.py (path:/tmp/pip-eiVeYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:16 INFO - Running setup.py (path:/tmp/pip-7BqOyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:16 INFO - Running setup.py (path:/tmp/pip-OXWMTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:16 INFO - Running setup.py (path:/tmp/pip-GhbLF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:16 INFO - Running setup.py (path:/tmp/pip-GWESOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:16 INFO - Running setup.py (path:/tmp/pip-9joFkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:16 INFO - Running setup.py (path:/tmp/pip-wcCQpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:16 INFO - Running setup.py (path:/tmp/pip-fyIg1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:16 INFO - Running setup.py (path:/tmp/pip-JtkhA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:16 INFO - Running setup.py (path:/tmp/pip-K9aZFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:16 INFO - Running setup.py (path:/tmp/pip-Z0ITl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:16 INFO - Running setup.py (path:/tmp/pip-RIoghd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:16 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)) 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:16 INFO - Running setup.py (path:/tmp/pip-eYrIwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:17 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)) 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:17 INFO - Running setup.py (path:/tmp/pip-Fck06k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:17 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)) 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:17 INFO - Running setup.py (path:/tmp/pip-GdnGsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:17 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)) 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:17 INFO - Running setup.py (path:/tmp/pip-mYXex9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:17 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)) 05:17:17 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)) 05:17:17 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)) 05:17:17 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)) 05:17:17 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)) 05:17:17 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)) 05:17:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:17 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 05:17:17 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 05:17:17 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 05:17:17 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 05:17:17 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 05:17:17 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 05:17:19 INFO - Downloading blessings-1.6.tar.gz 05:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:19 INFO - Installing collected packages: blessings 05:17:19 INFO - Running setup.py install for blessings 05:17:19 INFO - Successfully installed blessings 05:17:19 INFO - Cleaning up... 05:17:19 INFO - Return code: 0 05:17:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:19 INFO - Reading from file tmpfile_stdout 05:17:19 INFO - Current package versions: 05:17:19 INFO - argparse == 1.2.1 05:17:19 INFO - blessings == 1.6 05:17:19 INFO - blobuploader == 1.2.4 05:17:19 INFO - docopt == 0.6.1 05:17:19 INFO - functools32 == 3.2.3-2 05:17:19 INFO - jsonschema == 2.5.1 05:17:19 INFO - manifestparser == 1.1 05:17:19 INFO - mozInstall == 1.12 05:17:19 INFO - mozcrash == 0.17 05:17:19 INFO - mozdebug == 0.1 05:17:19 INFO - mozdevice == 0.48 05:17:19 INFO - mozfile == 1.2 05:17:19 INFO - mozhttpd == 0.7 05:17:19 INFO - mozinfo == 0.9 05:17:19 INFO - mozleak == 0.1 05:17:19 INFO - mozlog == 3.3 05:17:19 INFO - moznetwork == 0.27 05:17:19 INFO - mozprocess == 0.23 05:17:19 INFO - mozprofile == 0.28 05:17:19 INFO - mozrunner == 6.12 05:17:19 INFO - mozscreenshot == 0.1 05:17:19 INFO - mozsystemmonitor == 0.3 05:17:19 INFO - moztest == 0.7 05:17:19 INFO - mozversion == 1.4 05:17:19 INFO - psutil == 3.1.1 05:17:19 INFO - requests == 1.2.3 05:17:19 INFO - wsgiref == 0.1.2 05:17:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 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 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:19 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 05:17:19 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 05:17:19 INFO - Using env: {'DISPLAY': ':0', 05:17:19 INFO - 'HOME': '/home/cltbld', 05:17:19 INFO - 'LANG': 'en_US.UTF-8', 05:17:19 INFO - 'LANGUAGE': 'en_US:en', 05:17:19 INFO - 'LOGNAME': 'cltbld', 05:17:19 INFO - 'MAIL': '/var/mail/cltbld', 05:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:19 INFO - 'MOZ_NO_REMOTE': '1', 05:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:19 INFO - 'NO_EM_RESTART': '1', 05:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:19 INFO - 'PWD': '/builds/slave/test', 05:17:19 INFO - 'SHELL': '/bin/bash', 05:17:19 INFO - 'SHLVL': '1', 05:17:19 INFO - 'TERM': 'linux', 05:17:19 INFO - 'TMOUT': '86400', 05:17:19 INFO - 'USER': 'cltbld', 05:17:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:19 INFO - '_': '/tools/buildbot/bin/python'} 05:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 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)) 05:17:19 INFO - Cleaning up... 05:17:19 INFO - Return code: 0 05:17:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', '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 05:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:19 INFO - Using env: {'DISPLAY': ':0', 05:17:19 INFO - 'HOME': '/home/cltbld', 05:17:19 INFO - 'LANG': 'en_US.UTF-8', 05:17:19 INFO - 'LANGUAGE': 'en_US:en', 05:17:19 INFO - 'LOGNAME': 'cltbld', 05:17:19 INFO - 'MAIL': '/var/mail/cltbld', 05:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:19 INFO - 'MOZ_NO_REMOTE': '1', 05:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:19 INFO - 'NO_EM_RESTART': '1', 05:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:19 INFO - 'PWD': '/builds/slave/test', 05:17:19 INFO - 'SHELL': '/bin/bash', 05:17:19 INFO - 'SHLVL': '1', 05:17:19 INFO - 'TERM': 'linux', 05:17:19 INFO - 'TMOUT': '86400', 05:17:19 INFO - 'USER': 'cltbld', 05:17:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:19 INFO - '_': '/tools/buildbot/bin/python'} 05:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:20 INFO - Cleaning up... 05:17:20 INFO - Return code: 0 05:17:20 INFO - Running post-action listener: _resource_record_post_action 05:17:20 INFO - Running post-action listener: _start_resource_monitoring 05:17:20 INFO - Starting resource monitoring. 05:17:20 INFO - [mozharness: 2016-07-29 12:17:20.077641Z] Finished create-virtualenv step (success) 05:17:20 INFO - [mozharness: 2016-07-29 12:17:20.078586Z] Running install step. 05:17:20 INFO - Running pre-action listener: _resource_record_pre_action 05:17:20 INFO - Running main action method: install 05:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:20 INFO - Reading from file tmpfile_stdout 05:17:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:20 INFO - Reading from file tmpfile_stdout 05:17:20 INFO - Output received: 05:17:20 INFO - Usage: mozinstall [options] installer 05:17:20 INFO - Options: 05:17:20 INFO - -h, --help show this help message and exit 05:17:20 INFO - -d DEST, --destination=DEST 05:17:20 INFO - Directory to install application into. [default: 05:17:20 INFO - "/builds/slave/test"] 05:17:20 INFO - --app=APP Application being installed. [default: firefox] 05:17:20 INFO - mkdir: /builds/slave/test/build/application 05:17:20 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'] 05:17:20 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 05:17:36 INFO - Reading from file tmpfile_stdout 05:17:36 INFO - Output received: 05:17:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:36 INFO - Running post-action listener: _resource_record_post_action 05:17:36 INFO - [mozharness: 2016-07-29 12:17:36.341043Z] Finished install step (success) 05:17:36 INFO - [mozharness: 2016-07-29 12:17:36.341441Z] Running run-tests step. 05:17:36 INFO - Running pre-action listener: _resource_record_pre_action 05:17:36 INFO - Running main action method: run_tests 05:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:36 INFO - Python 2.7.3 05:17:36 INFO - Return code: 0 05:17:36 INFO - grabbing minidump binary from tooltool 05:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:36 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 0x212e3b0>, '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 0x212f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:36 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 05:17:36 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 05:17:36 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 05:17:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:36 INFO - Return code: 0 05:17:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:36 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/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 05:17:36 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/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 05:17:36 INFO - Using env: {'DISPLAY': ':0', 05:17:36 INFO - 'HOME': '/home/cltbld', 05:17:36 INFO - 'LANG': 'en_US.UTF-8', 05:17:36 INFO - 'LANGUAGE': 'en_US:en', 05:17:36 INFO - 'LOGNAME': 'cltbld', 05:17:36 INFO - 'MAIL': '/var/mail/cltbld', 05:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:36 INFO - 'MOZ_NO_REMOTE': '1', 05:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:36 INFO - 'NO_EM_RESTART': '1', 05:17:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:36 INFO - 'PWD': '/builds/slave/test', 05:17:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:36 INFO - 'SHELL': '/bin/bash', 05:17:36 INFO - 'SHLVL': '1', 05:17:36 INFO - 'TERM': 'linux', 05:17:36 INFO - 'TMOUT': '86400', 05:17:36 INFO - 'USER': 'cltbld', 05:17:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114', 05:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:36 INFO - '_': '/tools/buildbot/bin/python'} 05:17:36 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/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 05:17:36 INFO - mozversion application_buildid: 20160729040124 05:17:36 INFO - mozversion application_changeset: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c 05:17:36 INFO - mozversion application_display_name: Nightly 05:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:36 INFO - mozversion application_name: Firefox 05:17:36 INFO - mozversion application_remotingname: firefox 05:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:36 INFO - mozversion application_vendor: Mozilla 05:17:36 INFO - mozversion application_version: 50.0a1 05:17:36 INFO - mozversion platform_buildid: 20160729040124 05:17:36 INFO - mozversion platform_changeset: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c 05:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:36 INFO - mozversion platform_version: 50.0a1 05:17:36 INFO - using testdate: 1469794656 05:17:36 INFO - actual date: 1469794656 05:17:36 INFO - starting webserver on 'localhost:51258' 05:17:36 INFO - SUITE-START | Running 2 tests 05:17:36 INFO - TEST-START | dromaeo_css 05:17:36 INFO - operating with platform_type : linux_ 05:17:36 INFO - Initialising browser for dromaeo_css test... 05:17:36 INFO - TEST-INFO | started process 3291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0zZ2V0/profile http://localhost:51258/getInfo.html) 05:17:42 INFO - PROCESS | 3291 | __metrics Screen width/height:1600/1200 05:17:42 INFO - PROCESS | 3291 | colorDepth:24 05:17:42 INFO - PROCESS | 3291 | Browser inner width/height: 1024/697 05:17:42 INFO - PROCESS | 3291 | __metrics 05:17:43 INFO - PROCESS | 3291 | 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" 05:17:43 INFO - PROCESS | 3291 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:44 INFO - TEST-INFO | 3291: exit 0 05:17:44 INFO - Browser initialized. 05:17:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:44 INFO - TEST-INFO | started process 3371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0zZ2V0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:56 INFO - PROCESS | 3371 | RSS: Main: 157761536 05:17:56 INFO - PROCESS | 3371 | 05:18:48 INFO - PROCESS | 3371 | 1469794728306 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] 05:21:00 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51258/tests/dromaeo/cssquery-ext.html) 05:21:01 INFO - PROCESS | 3371 | RSS: Main: 278401024 05:21:01 INFO - PROCESS | 3371 | 05:24:04 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-ext.html (next: http://localhost:51258/tests/dromaeo/cssquery-jquery.html) 05:24:05 INFO - PROCESS | 3371 | RSS: Main: 246583296 05:24:05 INFO - PROCESS | 3371 | 05:27:07 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51258/tests/dromaeo/cssquery-mootools.html) 05:27:07 INFO - PROCESS | 3371 | RSS: Main: 188596224 05:27:07 INFO - PROCESS | 3371 | 05:30:10 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51258/tests/dromaeo/cssquery-prototype.html) 05:30:10 INFO - PROCESS | 3371 | RSS: Main: 189403136 05:30:10 INFO - PROCESS | 3371 | 05:33:13 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51258/tests/dromaeo/cssquery-yui.html) 05:33:14 INFO - PROCESS | 3371 | RSS: Main: 192557056 05:33:14 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | Cycle 1(1): loaded http://localhost:51258/tests/dromaeo/cssquery-yui.html (next: http://localhost:51258/tests/dromaeo/cssquery-dojo.html) 05:36:17 INFO - PROCESS | 3371 | RSS: Main: 278646784 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | __start_tp_report 05:36:17 INFO - PROCESS | 3371 | _x_x_mozilla_page_load 05:36:17 INFO - PROCESS | 3371 | _x_x_mozilla_page_load_details 05:36:17 INFO - PROCESS | 3371 | |i|pagename|runs| 05:36:17 INFO - PROCESS | 3371 | |0;dojo.html;2675.665541807274;2678.5044766718147;2703.134996801023;2713.837169769814;2722.4282900590874;4722.669413141081;4778.235482322824;4797.424309082906;4908.214685650297;4934.3585333906585;4775.952240477594;4825.107355139293;4835.298881662157;4876.317315575822;4910.337104490893;4392.0776636906285;4434.933475997863;4445.644348452116;4449.510553839092;4522.886927826798;4430.601245887886;4446.799894004777;4450.866474005785;4504;4521.909561808779;4372.6064654180955;4423.845165419195;4518.819247230107;4519.389882365871;4598.218302888517;4329.2423825830665;4394.978025109886;4405.295152775572;4413.029133590605;4470.865874023784;4382.978085109586;4403.647708183337;4415.227335216357;4451.198784218839;4454.35411865281;4660.4174478190225;4785.593224575915;4787.0904528139545;4805.543473370024;4810.182269014276;5136.563392111675;5232.8691782705355;5237.711925844077;5288.576913846883;5295.152775555931;5205.635605507616;5211.166213405837;5211.452797456288;5222.451642577551;5222.477752224785;4826.493218212072;4858.611311095104;4863.10032643962;4864.927026094611;4871.098846713369;5154.793808247703;5220;5258.447862974333;5318.25544423781;5318.44156363584;5108.6168537359845;5148.819791307286;5156.303898973591;5162.406323272797;5167.974160129251;5174.379074511007;5220.947790522122;5227.242049902743;5229.346331708536;5235.476452354734;4996.400431948116;5101.413337466165;5147;5157.742112894341;5161.793528258828;5154.845354639367;5156.510131537498;5174.042802081627;5206.114960456732;5219.138842091088;4309.978450107729;4342.630876375543;4380.189664912002;4431.290993441098;4440.444944381952;3729.3473642113063;3762.510873586471;3818.541774986964;3837.6737977272246;3846.8461261549223;4455.443069616298;4512.097580483916;4514.458265008155;4534.614557762561;4569.725816451024;5251.658642188246;5253.369595648546;5256.2904007959205;5263.736813159327;5266.8156614519075;4517.6837621366185;4524.276115821453;4527.094581083797;4556.476005259371;4570.9314360284625;4525.796339164745;4618.330342100377;4698.130845793539;4701.694389864648;4757.024809913959;4923.729194894244;4933.9506604933495;4937.136001199848;4937.9012419752125;4981.950180498148;5262.447443018428;5279.683219006872;5281.15501519755;5282.524572788468;5283.603729720363;4735.668503204743;4847.175980083465;4880.023995201045;4901.8480657046275;4940.6788558743565;5129.461406552258;5132.486751324837;5133.589312855037;5136.871578210575;5207.76565054581;5215.113430716711;5237.083510385591;5238.397584277857;5239.738013099406;5278.340207474066;4842.443119041214;5011.949880501148;5020.121478741279;5068.3917929847175;5085.974570127126;5018.04657115147;5024.346834911438;5025.070361983045;5040.57155141817;5099.6685215460875;4949.678270912524;4954.50454954516;5005.824796132118;5008.248762685626;5014.57376123019;4902.901941961212;5019.749012549285;5082.161443361804;5100.642954993264;5106.514881086291;5004.199328107486;5006.324146240357;5011.198208286657;5036.924446133385;5037.1688671370275 05:36:17 INFO - PROCESS | 3371 | |1;ext.html;565.2341077839527;576.017889498405;576.2767726503238;586.987446654521;595.1489370200611;26331.210063698094;37347.81326093369;38782.03044923875;38802.4179637305;43110;39264.21471570567;39576.80211598938;39638;39656.405153922715;39670.80164599173;7688.038995125623;7825.726099586515;7835.177306382833;7837.7648670539975;7838.568878711669;7722.073351197864;7807.297343239107;7808.960955195216;7814.374850012014;7818.687252509922;7823.804404889866;7878.369730421581;7881;7881.960590197041;7883.526988380687;7814.3357814585825;7857.842843143105;7858.09631892334;7860.960695196544;7861.2531809478005;7716.6527506262355;7777.377809775261;7787.766367008999;7789.571573563452;7790.376769858454;37303.62696373056;37648.43527347092;37677.058073548105;37724.811375943216;37769.62230377689;2961.437326907902;2962.303858593229;3085.6142982127235;3212.036389083289;3253.6908993645566;28593.14220573386;29379.55930661042;29487.41025179506;29515.852420737974;29925;2849.6153019342537;2888.277930517371;2903.2596687844675;2921.371905040405;2982.358792859524;254009;255324;262361;264737;265285;45446.318305225446;45568;45625.40311089096;45909.77045114753;45947.540524594995;34181.658183418345;35099.82450087733;35147;35171.4724279136;54658.72670636701;15246.771298430533;15343;15347.386104555915;15358.232088395758;15360.923195383952;11899.226550274205;11957.820632690517;11981.88018119825;11988.76022479563;11988.940055299841;17875.30184632458;17898.642027159385;17901.910490447466;17909.462716118538;17950.730739038925;6829.590224586541;6833.145856767904;6930.13373328334;6968.407685346802;7009.9299007010295;809.8623234050226;839.8236370362171;918.3984490158956;996.8155891160159;1011.4588695048114;26187.607185892226;27782.305442363697;27989.720102799118;28093.43813123726;28264;799.4963173200963;934.1125930366179;1010.1312870930993;1017.1862509991977;1044.4934206909643;13787.241701706302;14331.355089021019;14482.275886205647;14576.271186440848;14894;403485;406778;407450;409746;410262;45803.31295030577;46169.53830461652;46281.30578041332;46296.30555541669;46351.304730429074;1064.3667018124204;1129.5030186717981;1158.7103224193952;1167.1304877866044;1180.9371565591036;27439.176824695292;27902.44195116127;28550.57174142348;28856.422871542873;28889.71110288954;41373.37939930963;41776;41927.58072419237;41955.7902210487;42006.57993420149;324078;326243;326730;326804;326947;24521.632175517738;25550.616740748534;25588.74411255938;26769.06308279201;26883.327916802238;40663.593364067165;40805.1838963225;40880.88247755588;41524.3771343424;41964;34975.82512087423;35441;35558.46662300119;35710.64289357073;35946.28107437889;35457.46813797847;35651.82174089113;35665;35737;36184;34655.480167796995;35146.29707405787;35351.823240883634;35643;35663.28673426569;29561.852190738908;31473;31660.208494787814;31710;31723.84138079295;24157.51684966326;24328.75671243265;24386.634200487362;24957.251282461555;24981.75018249867 05:36:17 INFO - PROCESS | 3371 | |2;jquery.html;353.3145697347148;373.9738218324715;375.7707798243071;377.09873402567865;392.80359820089956;12737.299448530339;15637.843621563781;16214.675706485863;16819.15904204791;17840.37558685446;16853.578660533494;17229.655406891856;17343;17466.388676396327;17586.120693965284;5066.36670416198;5096.362954630671;5231.110711179109;5250.65870718402;5253.6322457428;3826.1773718650484;5179.300794392747;5259.368875734917;5795.971020144893;6112.908306375408;6140.570160088796;6152.630842149463;6158.6920653967345;6162.568620196588;6167.04410816322;6035.456808887199;6040.305364883051;6082.9695851520455;6100.511959043266;6112.786052488186;5161.200013997836;5339.70631615261;5342.198670199462;5344.4922732340365;5348.812791552277;20679.896600516902;20920.163193472243;21054.473638159016;21065.578688426147;21068;1851.3982955539368;1859.312054539829;1882.3882238272479;2094.068139677844;2274.454131008546;13033.15284506504;13300.3349832508;13300.467981280834;13404.381877664262;14207.71584568303;1691.2812054876752;1750.606113624437;1765.2938824470186;1771.5482551949171;1790.6776780179562;46089;63152.36847631511;65579.67210163918;70739;74056.62971685106;9911.504424778876;10155.543000564992;10233.897661023444;10264.948675256575;10603;14249.358778854976;14249.50126745559;14261.643458913402;14266.001379903515;14274;7410.5915577437545;7609.467337286447;7716.344110750537;7729.072511298567;7846;7336.7432139874845;7364.079490063742;7538.736144234926;7614.847703046019;7632.771016869503;4318.179545886272;4405.933910991338;4417.757023363746;4538.11506756186;4613.653975951817;1562.1876624155375;1728.9481315560554;1767.7790276215474;1835.109971663742;1841.9079046047643;650.3012498132692;827.5034979012664;837.4472847920343;875.369733791669;911.7811725185908;16745.581360465843;17133.742993855103;17656.382026629006;17962.461126166236;18052.548686282684;833.8195618457689;837.0541288344253;909.5270459361095;915.6200176926634;938.5354249646332;8635.136486351315;9773.120419162167;9852.80294394108;9883.802323953481;9903.108720215216;381488;388536;390511;396037;397390;80864;81082;81329;81422;81556.18443815605;887.0730087059039;890.1365675294953;895.2882458445681;908.1917093786535;910.5583791860943;14549.745176195174;14999.175045372609;15594.454194103151;15623.906326557031;15959.521214363587;32129;38883.805580971915;38964.610353896096;39013;39534;51192.488075118774;51195;51760.74119629378;52229;53746.46253537414;6963.442924566124;7095.609741464269;7138.678759455733;7318.414526837947;7345;8589.570521474026;11024.779504409706;11398.772024559628;12075.154739168525;12270.631881043582;9721.173700235558;10003.14973227284;10254.128399086161;10360.948195258976;10388.532516036645;10511.57953681844;10611.257211995395;10738.194635402533;10773.892261077603;10958.178136639624;10371.688849334532;10475.738106547396;10532.684019479428;10743.785124297627;11087.279326843729;7516.736914207976;7644.732434364993;7702.306792388712;8078.313343365645;8127.496413163583;9887.456189909624;10508.264421490729;10511.737206569896;10626.73433164177;10735.94632026835 05:36:17 INFO - PROCESS | 3371 | |3;mootools.html;1346.521984695433;1406.54990403071;1441.6828297774493;1641.417296859615;1657.2293883344244;7521.661525231364;8030.91969080309;8035.598220089001;8040.316573091287;8049.275565199131;6745.291744366845;7383.5200711953685;7636.618169091551;7672.46292759507;7883.487573307731;2105.52625659227;2137.540428807806;2137.95724085519;2139.935801925945;2142.025378452808;2100.233414803601;2123.596516661837;2155.2025750472267;2155.428811364982;2156.892155392232;2077.428707105543;2104.757952835428;2111.060578042772;2124.468882779305;2151.9139234430604;2044.31515442327;2047.9385618431322;2052.1278456655937;2052.671572548385;2055.0444043519688;2056.0439395680933;2097.2449918029497;2097.9475513112143;2098.8950552472315;2100.012993892868;7941.285284324381;7955.2840244378285;8011.799705007363;8015.719449819287;8020;4526.253168227238;4629.768511574408;4632.0967411354795;4640.141573808856;4643;2728.7544121029005;2796.231036464968;2821.083147976916;2829.349249672566;2830.957535636967;825.5088222507599;859.2696208223023;867.3104881619128;871.1767379826067;872.1104473437059;10047.899521004769;10085.596576136946;10140.239482038876;10160.441175735257;10204;4063.512378514597;4116.279651061112;4298.398224248608;4303.419038429772;4314.288142456522;8820.514871682119;8837.469751814911;8843.867341989875;8847.292216622654;8854.335924805666;4670.182718024332;4687.976560117246;4706.858794236178;4713.764311784397;4714.905701886011;3680.429533422324;4188.6230239278;4263.253930562201;4269.188854117708;4367.825286988485;3613.530241068697;3645.179834537261;3760.172761992357;3765.8305376257586;3792.6586607205486;1160.1299025730702;1228.4103630257525;1229.8401207842924;1238.0714464151886;1254.1221145198215;685.4584877946367;790.1861083084432;833.2375876073326;842.4902933725131;854.9358798090168;5068.543831055223;5088.440271570124;5205.297284866495;5222.242774797709;5393.191021346829;405.65924623316556;407.06984540325215;407.62294877238435;411.71180173878406;414;3511.4792616634536;3523.101609089717;3550.2840923212825;3579.4451859961746;3579.8031108288774;8927.732168034969;9345.112214339762;9377.1091746284;9391.389559678735;9435.103665151937;8964.775880602907;9291.488968106683;9330.673426430043;9351.39215950961;9357.578908949114;7230.240824713434;7423.591702456309;7434.851302974019;7439.590822504706;7440.218777028443;5379.462053794589;5409.675419474844;5480.26016487785;5482.506574408322;5519.503244707996;8456.704015359433;8536.829263414822;8600;8704.91295087041;8791;8727.258183054257;8748.47509149453;8809.383343165917;8825.382223244567;8826;6207.534434917489;6521.315261897433;6735.49483788708;6903.102596662603;6908.481863860331;7112.964435177791;7391.482596218213;7406.14829294638;7455.030845989987;7482.476226664081;6804.285550017375;6807.183138023469;6887.173539175331;7001.229864714775;7080.291970803085;6722.092517510074;6756.223034351113;6857.759978400732;6901.723931042702;6920.826979325557;6442.162518872704;6532.608043517404;6543.770968016097;6557.409833115043;6565.737370505126;4260.616544511009;4454.708134640918;4464.55354464564;4495.190865644216;4546.795394207203;4301.526832048409;4440.2673558862425;4499.595036446735;4558.6581006423985;4681.063787242633 05:36:17 INFO - PROCESS | 3371 | |4;prototype.html;289.55408670647194;301.7902557722383;310.86166655838156;312.30512110554037;314.80639406764845;4887.3890763654545;4924.187509061005;4942.802287908488;4944.851654450364;4950.356453661024;4886.242632391976;4887.144749668802;4887.975560122203;4892.241702536104;4892.975535122319;3908.433277174815;3916.3342231820516;3917.784521851297;3923.509561304837;3930.646241838234;3826.923461530768;3882.1265215326607;3919.7060220483577;3927.6465118139363;3932.921341573167;3817.7401457518954;3848.2303539292116;3883.4660309177857;3886;3892.3577609694366;3850.7665553978763;3856.595057518948;3856.9722767627277;3863.439801228806;3866.1107945172625;3227.2415982244156;3314.6188188358406;3316.286998295354;3409.8636054557787;3430.794152350842;4730.858074257778;4733.55031272032;4734.479207287196;4741;4752.548507891779;4365.672574556889;4394.055278115188;4400.44994375703;4407.3609326647775;4411.647068234533;4820.264704706303;4907.779149938261;5048.823291184791;5086.237064440326;5128.640995130342;3652.7625704329134;3657.9451308230396;3677.025588219124;3680.227152297994;3711.1464363196346;5384.73076346185;5389.137737961907;5399.78400863965;5401.054815407328;5401.621886467949;3687.6681098701247;3790.33669107905;3799.430085487199;3838.7120965927666;3844.2888065707934;3891.2217556488818;3895.8441662333757;3896.844126234919;3901.8929777920175;3913.706472014553;4410.911781764346;4410.985473341086;4412.6690498212765;4416.33754936762;4416.895776055986;5009.073321435473;5134.589232861362;5147.786451825751;5156.61325400589;5163.741812909339;1321.894248460121;1352.3576301256824;1354.1401210231575;1360.1634994478325;1364.3519328319167;846.0059430169526;857.6826574167598;859.26532814444;894.9955250223708;897.5018864530118;4059.715819892579;4061.9796901015898;4079.265732168179;4081.8367265309057;4100.159467309194;4624.653151013687;4635.304704294315;4668.673192876466;4670.509596492388;4698.624110071186;4092.690339091462;4107.630313271819;4114.670826333886;4121.752694838319;4122.876313710593;2400.423898264439;2464.1375518568716;2481.6029435290266;2483.298940225951;2519.395345117195;4728.929066064012;4829.6860704054125;4843.685160464559;4845.3216549683075;4848.393950756155;5142.228665700175;5210.374755029421;5330.653507521999;5342.091844386464;5349.3580770307035;4856.1987272099705;4896.951030489649;4929.457759646436;4961.305417241589;4965.733737896813;5256.737163141904;5268.525832675077;5290.153575427913;5294;5301.363836339664;5176.559992400688;5179.896402072013;5184.455632158569;5187.766550505161;5244.187150991603;4738.815296175956;4942.703437793743;4949.282354058713;4956.727379994135;5006.3992320921725;3835.5780864104368;3853.190829925747;3857.3056849767313;3857.8456861725217;3882.398228274622;5280.128778751463;5280.339957505312;5287.629865909349;5300.337457817773;5304.575633949352;4992.926520798046;5112.795488180431;5145.331106956071;5156.845294641017;5194.558462530727;5038.445770965118;5085.872853178552;5087.847364579068;5099.439061703136;5102.158143906362;4977.676451030671;4979.377577802775;4995.125852975642;5004.299398084198;5024.648274620741;4926.581240594446;5098.41368242642;5135.35808023997;5148.665336753099;5190.351206099238;4974.776135073858;4985.501449855131;4993.575546078624;5020.598352131894;5023.899522009467 05:36:17 INFO - PROCESS | 3371 | |5;yui.html;582.0541619867715;594.9970250148749;643.2859525926222;654.6235914349248;659.7822718502895;11989.460474278656;12246.755064898696;12720.93639531801;12873.356332183388;12903.419346129424;13305.46778128876;13470.797938030937;13474.595762127128;13476.39356228972;13479.460821567125;764.9770506884788;784.6704384158667;785.2893131715806;785.7485604606528;786.3984052200071;638.6200210874522;745.057502259642;776.4254451705725;780.1963977103593;783.9921600784005;808.454293351988;812.212154210415;817.1746535998625;818.758466252457;819.8196396792696;812.544974814106;813.1543195077143;813.259933460551;813.686730608714;813.7518056992615;488.4675703483185;496.94036715594;501.22560643805406;503.0643004012534;578.4331355271815;12579.308138052404;13160.210387376788;13213;13214.207147571176;13216.735665286737;11505.827412588818;11811.468483918245;11824.467898944567;12009.519619215222;12062.939685301604;10606;10819;10889.891101089046;10904.182186335976;10909.1818113641;3808.9619103808886;3837.7889216093104;3900;3902.9609703902884;3920.3335432976464;66870.66564667194;68015;69266;69424;69739.95390069204;9373.343865929455;9471.573779179953;9485.383450075724;9499.14507694297;9502.857457138149;16085.35658573644;17321.91339043322;17325.826741732675;17339.13304334778;17354.219060142324;6384.553081284358;6594.208694956636;6802.489813264025;6837.726490940406;7059.082319298561;3719.367707489733;3749.512563366745;3756.8121593920196;3804.372278574004;3900.4344370066183;2704.8241864278757;2801.089645865102;2829.957550636742;2830.5471124620376;2832.7167283271506;501.71653016045815;503.61221859168234;508.3899320815037;511.8336540624312;542.2814770429197;555.5805366947928;557.9637323573954;568.7923907773633;593.9627079118578;604.1541841421956;7850.136484986647;7917.168697286817;7938.166492518202;8161.836763264701;8180.550069746221;510.81865937592363;599.2240049136379;602.1449541650866;608.9573729838869;611.9724612392453;3713.2387860488534;4065.7153999220363;4096.938545921814;4151.6886233532605;4177.3316269396755;76729;102890;104360.47819760852;104903;107624;67350.66324668346;75722.62138689382;77566;79923.60038199888;81169;66945;67468.32531674621;70871.91280871871;71151;71715.6414217936;7549.811254718676;8212.958935205286;8433.451825631315;8443.408961372645;8465.407421480437;31332.686673132976;32124.83937580297;35814.104647382985;39314.94937581797;39695.2060958785;59241.70379148249;59712.402875972424;60743;61249;62203;10853.728656783644;11049.17131215146;11166.944165279447;11411.714707132389;11448.94275528617;11617.302961822317;11628.18602697803;11836.881631183578;11907.583234586747;12004.09969252327;11384.203105782515;11543.826842597537;11906.940465297617;12415.751684966432;12421.503139874303;10948.7408947972;11402.315861048364;11402.657920262405;11473.13951453661;11839.644810655695;10492.422916739653;10904.454777261264;10941.617043403443;11019;11019.83470247963;8997.775055623662;9348.626054957726;9605.615775369186;9679.225661946886;9863.112319891245;9403.764905877408;9649.469279189712;9959.950200248952;9971.900280997388;9975.900240997496 05:36:17 INFO - PROCESS | 3371 | __end_tp_report 05:36:17 INFO - PROCESS | 3371 | __start_cc_report 05:36:17 INFO - PROCESS | 3371 | _x_x_mozilla_cycle_collect,1169 05:36:17 INFO - PROCESS | 3371 | __end_cc_report 05:36:17 INFO - PROCESS | 3371 | __startTimestamp1469795777529__endTimestamp 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | ------- Summary: start ------- 05:36:17 INFO - PROCESS | 3371 | Number of tests: 6 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#0] dojo.html Cycles:165 Average:4797.54 Median:4934.36 stddev:512.08 (10.4%) stddev-sans-first:485.84 05:36:17 INFO - PROCESS | 3371 | Values: 2675.7 2678.5 2703.1 2713.8 2722.4 4722.7 4778.2 4797.4 4908.2 4934.4 4776.0 4825.1 4835.3 4876.3 4910.3 4392.1 4434.9 4445.6 4449.5 4522.9 4430.6 4446.8 4450.9 4504.0 4521.9 4372.6 4423.8 4518.8 4519.4 4598.2 4329.2 4395.0 4405.3 4413.0 4470.9 4383.0 4403.6 4415.2 4451.2 4454.4 4660.4 4785.6 4787.1 4805.5 4810.2 5136.6 5232.9 5237.7 5288.6 5295.2 5205.6 5211.2 5211.5 5222.5 5222.5 4826.5 4858.6 4863.1 4864.9 4871.1 5154.8 5220.0 5258.4 5318.3 5318.4 5108.6 5148.8 5156.3 5162.4 5168.0 5174.4 5220.9 5227.2 5229.3 5235.5 4996.4 5101.4 5147.0 5157.7 5161.8 5154.8 5156.5 5174.0 5206.1 5219.1 4310.0 4342.6 4380.2 4431.3 4440.4 3729.3 3762.5 3818.5 3837.7 3846.8 4455.4 4512.1 4514.5 4534.6 4569.7 5251.7 5253.4 5256.3 5263.7 5266.8 4517.7 4524.3 4527.1 4556.5 4570.9 4525.8 4618.3 4698.1 4701.7 4757.0 4923.7 4934.0 4937.1 4937.9 4982.0 5262.4 5279.7 5281.2 5282.5 5283.6 4735.7 4847.2 4880.0 4901.8 4940.7 5129.5 5132.5 5133.6 5136.9 5207.8 5215.1 5237.1 5238.4 5239.7 5278.3 4842.4 5011.9 5020.1 5068.4 5086.0 5018.0 5024.3 5025.1 5040.6 5099.7 4949.7 4954.5 5005.8 5008.2 5014.6 4902.9 5019.7 5082.2 5100.6 5106.5 5004.2 5006.3 5011.2 5036.9 5037.2 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#1] ext.html Cycles:180 Average:47517.16 Median:35600.73 stddev:88808.58 (249.5%) stddev-sans-first:88987.75 05:36:17 INFO - PROCESS | 3371 | Values: 565.2 576.0 576.3 587.0 595.1 26331.2 37347.8 38782.0 38802.4 43110.0 39264.2 39576.8 39638.0 39656.4 39670.8 7688.0 7825.7 7835.2 7837.8 7838.6 7722.1 7807.3 7809.0 7814.4 7818.7 7823.8 7878.4 7881.0 7882.0 7883.5 7814.3 7857.8 7858.1 7861.0 7861.3 7716.7 7777.4 7787.8 7789.6 7790.4 37303.6 37648.4 37677.1 37724.8 37769.6 2961.4 2962.3 3085.6 3212.0 3253.7 28593.1 29379.6 29487.4 29515.9 29925.0 2849.6 2888.3 2903.3 2921.4 2982.4 254009.0 255324.0 262361.0 264737.0 265285.0 45446.3 45568.0 45625.4 45909.8 45947.5 34181.7 35099.8 35147.0 35171.5 54658.7 15246.8 15343.0 15347.4 15358.2 15360.9 11899.2 11957.8 11981.9 11988.8 11988.9 17875.3 17898.6 17901.9 17909.5 17950.7 6829.6 6833.1 6930.1 6968.4 7009.9 809.9 839.8 918.4 996.8 1011.5 26187.6 27782.3 27989.7 28093.4 28264.0 799.5 934.1 1010.1 1017.2 1044.5 13787.2 14331.4 14482.3 14576.3 14894.0 403485.0 406778.0 407450.0 409746.0 410262.0 45803.3 46169.5 46281.3 46296.3 46351.3 1064.4 1129.5 1158.7 1167.1 1180.9 27439.2 27902.4 28550.6 28856.4 28889.7 41373.4 41776.0 41927.6 41955.8 42006.6 324078.0 326243.0 326730.0 326804.0 326947.0 24521.6 25550.6 25588.7 26769.1 26883.3 40663.6 40805.2 40880.9 41524.4 41964.0 34975.8 35441.0 35558.5 35710.6 35946.3 35457.5 35651.8 35665.0 35737.0 36184.0 34655.5 35146.3 35351.8 35643.0 35663.3 29561.9 31473.0 31660.2 31710.0 31723.8 24157.5 24328.8 24386.6 24957.3 24981.8 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#2] jquery.html Cycles:180 Average:24563.06 Median:396713.50 stddev:64524.38 (16.3%) stddev-sans-first:64679.78 05:36:17 INFO - PROCESS | 3371 | Values: 353.3 374.0 375.8 377.1 392.8 12737.3 15637.8 16214.7 16819.2 17840.4 16853.6 17229.7 17343.0 17466.4 17586.1 5066.4 5096.4 5231.1 5250.7 5253.6 3826.2 5179.3 5259.4 5796.0 6112.9 6140.6 6152.6 6158.7 6162.6 6167.0 6035.5 6040.3 6083.0 6100.5 6112.8 5161.2 5339.7 5342.2 5344.5 5348.8 20679.9 20920.2 21054.5 21065.6 21068.0 1851.4 1859.3 1882.4 2094.1 2274.5 13033.2 13300.3 13300.5 13404.4 14207.7 1691.3 1750.6 1765.3 1771.5 1790.7 46089.0 63152.4 65579.7 70739.0 74056.6 9911.5 10155.5 10233.9 10264.9 10603.0 14249.4 14249.5 14261.6 14266.0 14274.0 7410.6 7609.5 7716.3 7729.1 7846.0 7336.7 7364.1 7538.7 7614.8 7632.8 4318.2 4405.9 4417.8 4538.1 4613.7 1562.2 1728.9 1767.8 1835.1 1841.9 650.3 827.5 837.4 875.4 911.8 16745.6 17133.7 17656.4 17962.5 18052.5 833.8 837.1 909.5 915.6 938.5 8635.1 9773.1 9852.8 9883.8 9903.1 381488.0 388536.0 390511.0 396037.0 397390.0 80864.0 81082.0 81329.0 81422.0 81556.2 887.1 890.1 895.3 908.2 910.6 14549.7 14999.2 15594.5 15623.9 15959.5 32129.0 38883.8 38964.6 39013.0 39534.0 51192.5 51195.0 51760.7 52229.0 53746.5 6963.4 7095.6 7138.7 7318.4 7345.0 8589.6 11024.8 11398.8 12075.2 12270.6 9721.2 10003.1 10254.1 10360.9 10388.5 10511.6 10611.3 10738.2 10773.9 10958.2 10371.7 10475.7 10532.7 10743.8 11087.3 7516.7 7644.7 7702.3 8078.3 8127.5 9887.5 10508.3 10511.7 10626.7 10735.9 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#3] mootools.html Cycles:180 Average:5074.13 Median:5078.49 stddev:2834.97 (55.8%) stddev-sans-first:2829.09 05:36:17 INFO - PROCESS | 3371 | Values: 1346.5 1406.5 1441.7 1641.4 1657.2 7521.7 8030.9 8035.6 8040.3 8049.3 6745.3 7383.5 7636.6 7672.5 7883.5 2105.5 2137.5 2138.0 2139.9 2142.0 2100.2 2123.6 2155.2 2155.4 2156.9 2077.4 2104.8 2111.1 2124.5 2151.9 2044.3 2047.9 2052.1 2052.7 2055.0 2056.0 2097.2 2097.9 2098.9 2100.0 7941.3 7955.3 8011.8 8015.7 8020.0 4526.3 4629.8 4632.1 4640.1 4643.0 2728.8 2796.2 2821.1 2829.3 2831.0 825.5 859.3 867.3 871.2 872.1 10047.9 10085.6 10140.2 10160.4 10204.0 4063.5 4116.3 4298.4 4303.4 4314.3 8820.5 8837.5 8843.9 8847.3 8854.3 4670.2 4688.0 4706.9 4713.8 4714.9 3680.4 4188.6 4263.3 4269.2 4367.8 3613.5 3645.2 3760.2 3765.8 3792.7 1160.1 1228.4 1229.8 1238.1 1254.1 685.5 790.2 833.2 842.5 854.9 5068.5 5088.4 5205.3 5222.2 5393.2 405.7 407.1 407.6 411.7 414.0 3511.5 3523.1 3550.3 3579.4 3579.8 8927.7 9345.1 9377.1 9391.4 9435.1 8964.8 9291.5 9330.7 9351.4 9357.6 7230.2 7423.6 7434.9 7439.6 7440.2 5379.5 5409.7 5480.3 5482.5 5519.5 8456.7 8536.8 8600.0 8704.9 8791.0 8727.3 8748.5 8809.4 8825.4 8826.0 6207.5 6521.3 6735.5 6903.1 6908.5 7113.0 7391.5 7406.1 7455.0 7482.5 6804.3 6807.2 6887.2 7001.2 7080.3 6722.1 6756.2 6857.8 6901.7 6920.8 6442.2 6532.6 6543.8 6557.4 6565.7 4260.6 4454.7 4464.6 4495.2 4546.8 4301.5 4440.3 4499.6 4558.7 4681.1 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#4] prototype.html Cycles:180 Average:4217.67 Median:4746.77 stddev:1220.99 (25.7%) stddev-sans-first:1188.28 05:36:17 INFO - PROCESS | 3371 | Values: 289.6 301.8 310.9 312.3 314.8 4887.4 4924.2 4942.8 4944.9 4950.4 4886.2 4887.1 4888.0 4892.2 4893.0 3908.4 3916.3 3917.8 3923.5 3930.6 3826.9 3882.1 3919.7 3927.6 3932.9 3817.7 3848.2 3883.5 3886.0 3892.4 3850.8 3856.6 3857.0 3863.4 3866.1 3227.2 3314.6 3316.3 3409.9 3430.8 4730.9 4733.6 4734.5 4741.0 4752.5 4365.7 4394.1 4400.4 4407.4 4411.6 4820.3 4907.8 5048.8 5086.2 5128.6 3652.8 3657.9 3677.0 3680.2 3711.1 5384.7 5389.1 5399.8 5401.1 5401.6 3687.7 3790.3 3799.4 3838.7 3844.3 3891.2 3895.8 3896.8 3901.9 3913.7 4410.9 4411.0 4412.7 4416.3 4416.9 5009.1 5134.6 5147.8 5156.6 5163.7 1321.9 1352.4 1354.1 1360.2 1364.4 846.0 857.7 859.3 895.0 897.5 4059.7 4062.0 4079.3 4081.8 4100.2 4624.7 4635.3 4668.7 4670.5 4698.6 4092.7 4107.6 4114.7 4121.8 4122.9 2400.4 2464.1 2481.6 2483.3 2519.4 4728.9 4829.7 4843.7 4845.3 4848.4 5142.2 5210.4 5330.7 5342.1 5349.4 4856.2 4897.0 4929.5 4961.3 4965.7 5256.7 5268.5 5290.2 5294.0 5301.4 5176.6 5179.9 5184.5 5187.8 5244.2 4738.8 4942.7 4949.3 4956.7 5006.4 3835.6 3853.2 3857.3 3857.8 3882.4 5280.1 5280.3 5287.6 5300.3 5304.6 4992.9 5112.8 5145.3 5156.8 5194.6 5038.4 5085.9 5087.8 5099.4 5102.2 4977.7 4979.4 4995.1 5004.3 5024.6 4926.6 5098.4 5135.4 5148.7 5190.4 4974.8 4985.5 4993.6 5020.6 5023.9 05:36:17 INFO - PROCESS | 3371 | 05:36:17 INFO - PROCESS | 3371 | [#5] yui.html Cycles:180 Average:17179.18 Median:509.60 stddev:24774.31 (4861.5%) stddev-sans-first:24812.46 05:36:17 INFO - PROCESS | 3371 | Values: 582.1 595.0 643.3 654.6 659.8 11989.5 12246.8 12720.9 12873.4 12903.4 13305.5 13470.8 13474.6 13476.4 13479.5 765.0 784.7 785.3 785.7 786.4 638.6 745.1 776.4 780.2 784.0 808.5 812.2 817.2 818.8 819.8 812.5 813.2 813.3 813.7 813.8 488.5 496.9 501.2 503.1 578.4 12579.3 13160.2 13213.0 13214.2 13216.7 11505.8 11811.5 11824.5 12009.5 12062.9 10606.0 10819.0 10889.9 10904.2 10909.2 3809.0 3837.8 3900.0 3903.0 3920.3 66870.7 68015.0 69266.0 69424.0 69740.0 9373.3 9471.6 9485.4 9499.1 9502.9 16085.4 17321.9 17325.8 17339.1 17354.2 6384.6 6594.2 6802.5 6837.7 7059.1 3719.4 3749.5 3756.8 3804.4 3900.4 2704.8 2801.1 2830.0 2830.5 2832.7 501.7 503.6 508.4 511.8 542.3 555.6 558.0 568.8 594.0 604.2 7850.1 7917.2 7938.2 8161.8 8180.6 510.8 599.2 602.1 609.0 612.0 3713.2 4065.7 4096.9 4151.7 4177.3 76729.0 102890.0 104360.5 104903.0 107624.0 67350.7 75722.6 77566.0 79923.6 81169.0 66945.0 67468.3 70871.9 71151.0 71715.6 7549.8 8213.0 8433.5 8443.4 8465.4 31332.7 32124.8 35814.1 39314.9 39695.2 59241.7 59712.4 60743.0 61249.0 62203.0 10853.7 11049.2 11166.9 11411.7 11448.9 11617.3 11628.2 11836.9 11907.6 12004.1 11384.2 11543.8 11906.9 12415.8 12421.5 10948.7 11402.3 11402.7 11473.1 11839.6 10492.4 10904.5 10941.6 11019.0 11019.8 8997.8 9348.6 9605.6 9679.2 9863.1 9403.8 9649.5 9960.0 9971.9 9975.9 05:36:17 INFO - PROCESS | 3371 | -------- Summary: end -------- 05:36:17 INFO - PROCESS | 3371 | 05:36:18 INFO - TEST-INFO | 3371: exit 0 05:36:18 INFO - TEST-OK | dromaeo_css | took 1121642ms 05:36:18 INFO - TEST-START | kraken 05:36:18 INFO - operating with platform_type : linux_ 05:36:18 INFO - Initialising browser for kraken test... 05:36:18 INFO - TEST-INFO | started process 3587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZF0PO/profile http://localhost:51258/getInfo.html) 05:36:22 INFO - PROCESS | 3587 | __metrics Screen width/height:1600/1200 05:36:22 INFO - PROCESS | 3587 | colorDepth:24 05:36:22 INFO - PROCESS | 3587 | Browser inner width/height: 1024/697 05:36:22 INFO - PROCESS | 3587 | __metrics 05:36:23 INFO - PROCESS | 3587 | 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" 05:36:23 INFO - PROCESS | 3587 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:24 INFO - PROCESS | 3587 | console.error: PushService: 05:36:24 INFO - PROCESS | 3587 | stateChangeProcessEnqueue: Error transitioning state 05:36:24 INFO - PROCESS | 3587 | UnknownError 05:36:24 INFO - TEST-INFO | 3587: exit 0 05:36:24 INFO - Browser initialized. 05:36:24 INFO - Running cycle 1/1 for kraken test... 05:36:24 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZF0PO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:36 INFO - PROCESS | 3664 | RSS: Main: 157339648 05:36:36 INFO - PROCESS | 3664 | 05:36:39 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51258/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:40 INFO - PROCESS | 3664 | RSS: Main: 213561344 05:36:40 INFO - PROCESS | 3664 | 05:36:42 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51258/tests/kraken/driver.html?testName=audio-dft) 05:36:43 INFO - PROCESS | 3664 | RSS: Main: 191488000 05:36:43 INFO - PROCESS | 3664 | 05:36:46 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51258/tests/kraken/driver.html?testName=audio-fft) 05:36:47 INFO - PROCESS | 3664 | RSS: Main: 270721024 05:36:47 INFO - PROCESS | 3664 | 05:36:49 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51258/tests/kraken/driver.html?testName=audio-oscillator) 05:36:50 INFO - PROCESS | 3664 | RSS: Main: 180854784 05:36:50 INFO - PROCESS | 3664 | 05:36:52 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:52 INFO - PROCESS | 3664 | RSS: Main: 185016320 05:36:52 INFO - PROCESS | 3664 | 05:36:56 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51258/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:56 INFO - PROCESS | 3664 | RSS: Main: 221663232 05:36:56 INFO - PROCESS | 3664 | 05:37:00 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51258/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:00 INFO - PROCESS | 3664 | RSS: Main: 220512256 05:37:00 INFO - PROCESS | 3664 | 05:37:03 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51258/tests/kraken/driver.html?testName=json-parse-financial) 05:37:04 INFO - PROCESS | 3664 | RSS: Main: 220217344 05:37:04 INFO - PROCESS | 3664 | 05:37:05 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:06 INFO - PROCESS | 3664 | RSS: Main: 185319424 05:37:06 INFO - PROCESS | 3664 | 05:37:08 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:09 INFO - PROCESS | 3664 | RSS: Main: 190214144 05:37:09 INFO - PROCESS | 3664 | 05:37:11 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:11 INFO - PROCESS | 3664 | RSS: Main: 194707456 05:37:11 INFO - PROCESS | 3664 | 05:37:14 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:15 INFO - PROCESS | 3664 | RSS: Main: 189734912 05:37:15 INFO - PROCESS | 3664 | 05:37:18 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:18 INFO - PROCESS | 3664 | RSS: Main: 193044480 05:37:18 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:51258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51258/tests/kraken/driver.html?testName=ai-astar) 05:37:20 INFO - PROCESS | 3664 | RSS: Main: 244166656 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | __start_tp_report 05:37:20 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 05:37:20 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 05:37:20 INFO - PROCESS | 3664 | |i|pagename|runs| 05:37:20 INFO - PROCESS | 3664 | |0;ai-astar;104;113;112;115;115;114;113;115;112;112 05:37:20 INFO - PROCESS | 3664 | |1;audio-beat-detection;151;121;122;180;126;124;163;129;170;121 05:37:20 INFO - PROCESS | 3664 | |2;audio-dft;161;160;160;161;162;161;161;161;161;161 05:37:20 INFO - PROCESS | 3664 | |3;audio-fft;75;75;76;116;77;76;76;77;104;75 05:37:20 INFO - PROCESS | 3664 | |4;audio-oscillator;85;87;114;86;84;85;129;84;85;136 05:37:20 INFO - PROCESS | 3664 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;116 05:37:20 INFO - PROCESS | 3664 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;146 05:37:20 INFO - PROCESS | 3664 | |7;imaging-desaturate;95;95;96;94;95;95;95;96;95;95 05:37:20 INFO - PROCESS | 3664 | |8;json-parse-financial;61;61;59;60;60;60;61;61;60;62 05:37:20 INFO - PROCESS | 3664 | |9;json-stringify-tinderbox;65;67;65;66;65;65;66;65;66;66 05:37:20 INFO - PROCESS | 3664 | |10;stanford-crypto-aes;88;81;77;77;81;78;77;78;78;80 05:37:20 INFO - PROCESS | 3664 | |11;stanford-crypto-ccm;130;135;127;130;128;127;138;126;179;130 05:37:20 INFO - PROCESS | 3664 | |12;stanford-crypto-pbkdf2;165;167;166;163;165;164;164;166;164;164 05:37:20 INFO - PROCESS | 3664 | |13;stanford-crypto-sha256-iterative;67;67;68;66;67;68;67;70;67;68 05:37:20 INFO - PROCESS | 3664 | __end_tp_report 05:37:20 INFO - PROCESS | 3664 | __start_cc_report 05:37:20 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,1934 05:37:20 INFO - PROCESS | 3664 | __end_cc_report 05:37:20 INFO - PROCESS | 3664 | __startTimestamp1469795840757__endTimestamp 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | ------- Summary: start ------- 05:37:20 INFO - PROCESS | 3664 | Number of tests: 14 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.24 (2.9%) stddev-sans-first:1.33 05:37:20 INFO - PROCESS | 3664 | Values: 104.0 113.0 112.0 115.0 115.0 114.0 113.0 115.0 112.0 112.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:140.00 stddev:23.01 (16.4%) stddev-sans-first:24.10 05:37:20 INFO - PROCESS | 3664 | Values: 151.0 121.0 122.0 180.0 126.0 124.0 163.0 129.0 170.0 121.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:37:20 INFO - PROCESS | 3664 | Values: 161.0 160.0 160.0 161.0 162.0 161.0 161.0 161.0 161.0 161.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.68 (19.3%) stddev-sans-first:15.31 05:37:20 INFO - PROCESS | 3664 | Values: 75.0 75.0 76.0 116.0 77.0 76.0 76.0 77.0 104.0 75.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.61 (24.2%) stddev-sans-first:21.36 05:37:20 INFO - PROCESS | 3664 | Values: 85.0 87.0 114.0 86.0 84.0 85.0 129.0 84.0 85.0 136.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:37:20 INFO - PROCESS | 3664 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:37:20 INFO - PROCESS | 3664 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:37:20 INFO - PROCESS | 3664 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 05:37:20 INFO - PROCESS | 3664 | Values: 61.0 61.0 59.0 60.0 60.0 60.0 61.0 61.0 60.0 62.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 05:37:20 INFO - PROCESS | 3664 | Values: 65.0 67.0 65.0 66.0 65.0 65.0 66.0 65.0 66.0 66.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:3.37 (4.3%) stddev-sans-first:1.67 05:37:20 INFO - PROCESS | 3664 | Values: 88.0 81.0 77.0 77.0 81.0 78.0 77.0 78.0 78.0 80.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:130.00 stddev:15.91 (12.2%) stddev-sans-first:16.77 05:37:20 INFO - PROCESS | 3664 | Values: 130.0 135.0 127.0 130.0 128.0 127.0 138.0 126.0 179.0 130.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 05:37:20 INFO - PROCESS | 3664 | Values: 165.0 167.0 166.0 163.0 165.0 164.0 164.0 166.0 164.0 164.0 05:37:20 INFO - PROCESS | 3664 | 05:37:20 INFO - PROCESS | 3664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 05:37:20 INFO - PROCESS | 3664 | Values: 67.0 67.0 68.0 66.0 67.0 68.0 67.0 70.0 67.0 68.0 05:37:20 INFO - PROCESS | 3664 | -------- Summary: end -------- 05:37:20 INFO - PROCESS | 3664 | 05:37:21 INFO - TEST-INFO | 3664: exit 0 05:37:21 INFO - TEST-OK | kraken | took 63564ms 05:37:21 INFO - SUITE-END | took 1185s 05:37:22 INFO - Completed test suite (00:19:45) 05:37:22 INFO - javascript benchmark 05:37:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.665541807274, 2678.5044766718147, 2703.134996801023, 2713.837169769814, 2722.4282900590874, 4722.669413141081, 4778.235482322824, 4797.424309082906, 4908.214685650297, 4934.3585333906585, 4775.952240477594, 4825.107355139293, 4835.298881662157, 4876.317315575822, 4910.337104490893, 4392.0776636906285, 4434.933475997863, 4445.644348452116, 4449.510553839092, 4522.886927826798, 4430.601245887886, 4446.799894004777, 4450.866474005785, 4504.0, 4521.909561808779, 4372.6064654180955, 4423.845165419195, 4518.819247230107, 4519.389882365871, 4598.218302888517, 4329.2423825830665, 4394.978025109886, 4405.295152775572, 4413.029133590605, 4470.865874023784, 4382.978085109586, 4403.647708183337, 4415.227335216357, 4451.198784218839, 4454.35411865281, 4660.4174478190225, 4785.593224575915, 4787.0904528139545, 4805.543473370024, 4810.182269014276, 5136.563392111675, 5232.8691782705355, 5237.711925844077, 5288.576913846883, 5295.152775555931, 5205.635605507616, 5211.166213405837, 5211.452797456288, 5222.451642577551, 5222.477752224785, 4826.493218212072, 4858.611311095104, 4863.10032643962, 4864.927026094611, 4871.098846713369, 5154.793808247703, 5220.0, 5258.447862974333, 5318.25544423781, 5318.44156363584, 5108.6168537359845, 5148.819791307286, 5156.303898973591, 5162.406323272797, 5167.974160129251, 5174.379074511007, 5220.947790522122, 5227.242049902743, 5229.346331708536, 5235.476452354734, 4996.400431948116, 5101.413337466165, 5147.0, 5157.742112894341, 5161.793528258828, 5154.845354639367, 5156.510131537498, 5174.042802081627, 5206.114960456732, 5219.138842091088, 4309.978450107729, 4342.630876375543, 4380.189664912002, 4431.290993441098, 4440.444944381952, 3729.3473642113063, 3762.510873586471, 3818.541774986964, 3837.6737977272246, 3846.8461261549223, 4455.443069616298, 4512.097580483916, 4514.458265008155, 4534.614557762561, 4569.725816451024, 5251.658642188246, 5253.369595648546, 5256.2904007959205, 5263.736813159327, 5266.8156614519075, 4517.6837621366185, 4524.276115821453, 4527.094581083797, 4556.476005259371, 4570.9314360284625, 4525.796339164745, 4618.330342100377, 4698.130845793539, 4701.694389864648, 4757.024809913959, 4923.729194894244, 4933.9506604933495, 4937.136001199848, 4937.9012419752125, 4981.950180498148, 5262.447443018428, 5279.683219006872, 5281.15501519755, 5282.524572788468, 5283.603729720363, 4735.668503204743, 4847.175980083465, 4880.023995201045, 4901.8480657046275, 4940.6788558743565, 5129.461406552258, 5132.486751324837, 5133.589312855037, 5136.871578210575, 5207.76565054581, 5215.113430716711, 5237.083510385591, 5238.397584277857, 5239.738013099406, 5278.340207474066, 4842.443119041214, 5011.949880501148, 5020.121478741279, 5068.3917929847175, 5085.974570127126, 5018.04657115147, 5024.346834911438, 5025.070361983045, 5040.57155141817, 5099.6685215460875, 4949.678270912524, 4954.50454954516, 5005.824796132118, 5008.248762685626, 5014.57376123019, 4902.901941961212, 5019.749012549285, 5082.161443361804, 5100.642954993264, 5106.514881086291, 5004.199328107486, 5006.324146240357, 5011.198208286657, 5036.924446133385, 5037.1688671370275], "value": 4764.280964728794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2341077839527, 576.017889498405, 576.2767726503238, 586.987446654521, 595.1489370200611, 26331.210063698094, 37347.81326093369, 38782.03044923875, 38802.4179637305, 43110.0, 39264.21471570567, 39576.80211598938, 39638.0, 39656.405153922715, 39670.80164599173, 7688.038995125623, 7825.726099586515, 7835.177306382833, 7837.7648670539975, 7838.568878711669, 7722.073351197864, 7807.297343239107, 7808.960955195216, 7814.374850012014, 7818.687252509922, 7823.804404889866, 7878.369730421581, 7881.0, 7881.960590197041, 7883.526988380687, 7814.3357814585825, 7857.842843143105, 7858.09631892334, 7860.960695196544, 7861.2531809478005, 7716.6527506262355, 7777.377809775261, 7787.766367008999, 7789.571573563452, 7790.376769858454, 37303.62696373056, 37648.43527347092, 37677.058073548105, 37724.811375943216, 37769.62230377689, 2961.437326907902, 2962.303858593229, 3085.6142982127235, 3212.036389083289, 3253.6908993645566, 28593.14220573386, 29379.55930661042, 29487.41025179506, 29515.852420737974, 29925.0, 2849.6153019342537, 2888.277930517371, 2903.2596687844675, 2921.371905040405, 2982.358792859524, 254009.0, 255324.0, 262361.0, 264737.0, 265285.0, 45446.318305225446, 45568.0, 45625.40311089096, 45909.77045114753, 45947.540524594995, 34181.658183418345, 35099.82450087733, 35147.0, 35171.4724279136, 54658.72670636701, 15246.771298430533, 15343.0, 15347.386104555915, 15358.232088395758, 15360.923195383952, 11899.226550274205, 11957.820632690517, 11981.88018119825, 11988.76022479563, 11988.940055299841, 17875.30184632458, 17898.642027159385, 17901.910490447466, 17909.462716118538, 17950.730739038925, 6829.590224586541, 6833.145856767904, 6930.13373328334, 6968.407685346802, 7009.9299007010295, 809.8623234050226, 839.8236370362171, 918.3984490158956, 996.8155891160159, 1011.4588695048114, 26187.607185892226, 27782.305442363697, 27989.720102799118, 28093.43813123726, 28264.0, 799.4963173200963, 934.1125930366179, 1010.1312870930993, 1017.1862509991977, 1044.4934206909643, 13787.241701706302, 14331.355089021019, 14482.275886205647, 14576.271186440848, 14894.0, 403485.0, 406778.0, 407450.0, 409746.0, 410262.0, 45803.31295030577, 46169.53830461652, 46281.30578041332, 46296.30555541669, 46351.304730429074, 1064.3667018124204, 1129.5030186717981, 1158.7103224193952, 1167.1304877866044, 1180.9371565591036, 27439.176824695292, 27902.44195116127, 28550.57174142348, 28856.422871542873, 28889.71110288954, 41373.37939930963, 41776.0, 41927.58072419237, 41955.7902210487, 42006.57993420149, 324078.0, 326243.0, 326730.0, 326804.0, 326947.0, 24521.632175517738, 25550.616740748534, 25588.74411255938, 26769.06308279201, 26883.327916802238, 40663.593364067165, 40805.1838963225, 40880.88247755588, 41524.3771343424, 41964.0, 34975.82512087423, 35441.0, 35558.46662300119, 35710.64289357073, 35946.28107437889, 35457.46813797847, 35651.82174089113, 35665.0, 35737.0, 36184.0, 34655.480167796995, 35146.29707405787, 35351.823240883634, 35643.0, 35663.28673426569, 29561.852190738908, 31473.0, 31660.208494787814, 31710.0, 31723.84138079295, 24157.51684966326, 24328.75671243265, 24386.634200487362, 24957.251282461555, 24981.75018249867], "value": 17158.142434685204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3145697347148, 373.9738218324715, 375.7707798243071, 377.09873402567865, 392.80359820089956, 12737.299448530339, 15637.843621563781, 16214.675706485863, 16819.15904204791, 17840.37558685446, 16853.578660533494, 17229.655406891856, 17343.0, 17466.388676396327, 17586.120693965284, 5066.36670416198, 5096.362954630671, 5231.110711179109, 5250.65870718402, 5253.6322457428, 3826.1773718650484, 5179.300794392747, 5259.368875734917, 5795.971020144893, 6112.908306375408, 6140.570160088796, 6152.630842149463, 6158.6920653967345, 6162.568620196588, 6167.04410816322, 6035.456808887199, 6040.305364883051, 6082.9695851520455, 6100.511959043266, 6112.786052488186, 5161.200013997836, 5339.70631615261, 5342.198670199462, 5344.4922732340365, 5348.812791552277, 20679.896600516902, 20920.163193472243, 21054.473638159016, 21065.578688426147, 21068.0, 1851.3982955539368, 1859.312054539829, 1882.3882238272479, 2094.068139677844, 2274.454131008546, 13033.15284506504, 13300.3349832508, 13300.467981280834, 13404.381877664262, 14207.71584568303, 1691.2812054876752, 1750.606113624437, 1765.2938824470186, 1771.5482551949171, 1790.6776780179562, 46089.0, 63152.36847631511, 65579.67210163918, 70739.0, 74056.62971685106, 9911.504424778876, 10155.543000564992, 10233.897661023444, 10264.948675256575, 10603.0, 14249.358778854976, 14249.50126745559, 14261.643458913402, 14266.001379903515, 14274.0, 7410.5915577437545, 7609.467337286447, 7716.344110750537, 7729.072511298567, 7846.0, 7336.7432139874845, 7364.079490063742, 7538.736144234926, 7614.847703046019, 7632.771016869503, 4318.179545886272, 4405.933910991338, 4417.757023363746, 4538.11506756186, 4613.653975951817, 1562.1876624155375, 1728.9481315560554, 1767.7790276215474, 1835.109971663742, 1841.9079046047643, 650.3012498132692, 827.5034979012664, 837.4472847920343, 875.369733791669, 911.7811725185908, 16745.581360465843, 17133.742993855103, 17656.382026629006, 17962.461126166236, 18052.548686282684, 833.8195618457689, 837.0541288344253, 909.5270459361095, 915.6200176926634, 938.5354249646332, 8635.136486351315, 9773.120419162167, 9852.80294394108, 9883.802323953481, 9903.108720215216, 381488.0, 388536.0, 390511.0, 396037.0, 397390.0, 80864.0, 81082.0, 81329.0, 81422.0, 81556.18443815605, 887.0730087059039, 890.1365675294953, 895.2882458445681, 908.1917093786535, 910.5583791860943, 14549.745176195174, 14999.175045372609, 15594.454194103151, 15623.906326557031, 15959.521214363587, 32129.0, 38883.805580971915, 38964.610353896096, 39013.0, 39534.0, 51192.488075118774, 51195.0, 51760.74119629378, 52229.0, 53746.46253537414, 6963.442924566124, 7095.609741464269, 7138.678759455733, 7318.414526837947, 7345.0, 8589.570521474026, 11024.779504409706, 11398.772024559628, 12075.154739168525, 12270.631881043582, 9721.173700235558, 10003.14973227284, 10254.128399086161, 10360.948195258976, 10388.532516036645, 10511.57953681844, 10611.257211995395, 10738.194635402533, 10773.892261077603, 10958.178136639624, 10371.688849334532, 10475.738106547396, 10532.684019479428, 10743.785124297627, 11087.279326843729, 7516.736914207976, 7644.732434364993, 7702.306792388712, 8078.313343365645, 8127.496413163583, 9887.456189909624, 10508.264421490729, 10511.737206569896, 10626.73433164177, 10735.94632026835], "value": 8390.502554593742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.521984695433, 1406.54990403071, 1441.6828297774493, 1641.417296859615, 1657.2293883344244, 7521.661525231364, 8030.91969080309, 8035.598220089001, 8040.316573091287, 8049.275565199131, 6745.291744366845, 7383.5200711953685, 7636.618169091551, 7672.46292759507, 7883.487573307731, 2105.52625659227, 2137.540428807806, 2137.95724085519, 2139.935801925945, 2142.025378452808, 2100.233414803601, 2123.596516661837, 2155.2025750472267, 2155.428811364982, 2156.892155392232, 2077.428707105543, 2104.757952835428, 2111.060578042772, 2124.468882779305, 2151.9139234430604, 2044.31515442327, 2047.9385618431322, 2052.1278456655937, 2052.671572548385, 2055.0444043519688, 2056.0439395680933, 2097.2449918029497, 2097.9475513112143, 2098.8950552472315, 2100.012993892868, 7941.285284324381, 7955.2840244378285, 8011.799705007363, 8015.719449819287, 8020.0, 4526.253168227238, 4629.768511574408, 4632.0967411354795, 4640.141573808856, 4643.0, 2728.7544121029005, 2796.231036464968, 2821.083147976916, 2829.349249672566, 2830.957535636967, 825.5088222507599, 859.2696208223023, 867.3104881619128, 871.1767379826067, 872.1104473437059, 10047.899521004769, 10085.596576136946, 10140.239482038876, 10160.441175735257, 10204.0, 4063.512378514597, 4116.279651061112, 4298.398224248608, 4303.419038429772, 4314.288142456522, 8820.514871682119, 8837.469751814911, 8843.867341989875, 8847.292216622654, 8854.335924805666, 4670.182718024332, 4687.976560117246, 4706.858794236178, 4713.764311784397, 4714.905701886011, 3680.429533422324, 4188.6230239278, 4263.253930562201, 4269.188854117708, 4367.825286988485, 3613.530241068697, 3645.179834537261, 3760.172761992357, 3765.8305376257586, 3792.6586607205486, 1160.1299025730702, 1228.4103630257525, 1229.8401207842924, 1238.0714464151886, 1254.1221145198215, 685.4584877946367, 790.1861083084432, 833.2375876073326, 842.4902933725131, 854.9358798090168, 5068.543831055223, 5088.440271570124, 5205.297284866495, 5222.242774797709, 5393.191021346829, 405.65924623316556, 407.06984540325215, 407.62294877238435, 411.71180173878406, 414.0, 3511.4792616634536, 3523.101609089717, 3550.2840923212825, 3579.4451859961746, 3579.8031108288774, 8927.732168034969, 9345.112214339762, 9377.1091746284, 9391.389559678735, 9435.103665151937, 8964.775880602907, 9291.488968106683, 9330.673426430043, 9351.39215950961, 9357.578908949114, 7230.240824713434, 7423.591702456309, 7434.851302974019, 7439.590822504706, 7440.218777028443, 5379.462053794589, 5409.675419474844, 5480.26016487785, 5482.506574408322, 5519.503244707996, 8456.704015359433, 8536.829263414822, 8600.0, 8704.91295087041, 8791.0, 8727.258183054257, 8748.47509149453, 8809.383343165917, 8825.382223244567, 8826.0, 6207.534434917489, 6521.315261897433, 6735.49483788708, 6903.102596662603, 6908.481863860331, 7112.964435177791, 7391.482596218213, 7406.14829294638, 7455.030845989987, 7482.476226664081, 6804.285550017375, 6807.183138023469, 6887.173539175331, 7001.229864714775, 7080.291970803085, 6722.092517510074, 6756.223034351113, 6857.759978400732, 6901.723931042702, 6920.826979325557, 6442.162518872704, 6532.608043517404, 6543.770968016097, 6557.409833115043, 6565.737370505126, 4260.616544511009, 4454.708134640918, 4464.55354464564, 4495.190865644216, 4546.795394207203, 4301.526832048409, 4440.2673558862425, 4499.595036446735, 4558.6581006423985, 4681.063787242633], "value": 4011.880567389676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.55408670647194, 301.7902557722383, 310.86166655838156, 312.30512110554037, 314.80639406764845, 4887.3890763654545, 4924.187509061005, 4942.802287908488, 4944.851654450364, 4950.356453661024, 4886.242632391976, 4887.144749668802, 4887.975560122203, 4892.241702536104, 4892.975535122319, 3908.433277174815, 3916.3342231820516, 3917.784521851297, 3923.509561304837, 3930.646241838234, 3826.923461530768, 3882.1265215326607, 3919.7060220483577, 3927.6465118139363, 3932.921341573167, 3817.7401457518954, 3848.2303539292116, 3883.4660309177857, 3886.0, 3892.3577609694366, 3850.7665553978763, 3856.595057518948, 3856.9722767627277, 3863.439801228806, 3866.1107945172625, 3227.2415982244156, 3314.6188188358406, 3316.286998295354, 3409.8636054557787, 3430.794152350842, 4730.858074257778, 4733.55031272032, 4734.479207287196, 4741.0, 4752.548507891779, 4365.672574556889, 4394.055278115188, 4400.44994375703, 4407.3609326647775, 4411.647068234533, 4820.264704706303, 4907.779149938261, 5048.823291184791, 5086.237064440326, 5128.640995130342, 3652.7625704329134, 3657.9451308230396, 3677.025588219124, 3680.227152297994, 3711.1464363196346, 5384.73076346185, 5389.137737961907, 5399.78400863965, 5401.054815407328, 5401.621886467949, 3687.6681098701247, 3790.33669107905, 3799.430085487199, 3838.7120965927666, 3844.2888065707934, 3891.2217556488818, 3895.8441662333757, 3896.844126234919, 3901.8929777920175, 3913.706472014553, 4410.911781764346, 4410.985473341086, 4412.6690498212765, 4416.33754936762, 4416.895776055986, 5009.073321435473, 5134.589232861362, 5147.786451825751, 5156.61325400589, 5163.741812909339, 1321.894248460121, 1352.3576301256824, 1354.1401210231575, 1360.1634994478325, 1364.3519328319167, 846.0059430169526, 857.6826574167598, 859.26532814444, 894.9955250223708, 897.5018864530118, 4059.715819892579, 4061.9796901015898, 4079.265732168179, 4081.8367265309057, 4100.159467309194, 4624.653151013687, 4635.304704294315, 4668.673192876466, 4670.509596492388, 4698.624110071186, 4092.690339091462, 4107.630313271819, 4114.670826333886, 4121.752694838319, 4122.876313710593, 2400.423898264439, 2464.1375518568716, 2481.6029435290266, 2483.298940225951, 2519.395345117195, 4728.929066064012, 4829.6860704054125, 4843.685160464559, 4845.3216549683075, 4848.393950756155, 5142.228665700175, 5210.374755029421, 5330.653507521999, 5342.091844386464, 5349.3580770307035, 4856.1987272099705, 4896.951030489649, 4929.457759646436, 4961.305417241589, 4965.733737896813, 5256.737163141904, 5268.525832675077, 5290.153575427913, 5294.0, 5301.363836339664, 5176.559992400688, 5179.896402072013, 5184.455632158569, 5187.766550505161, 5244.187150991603, 4738.815296175956, 4942.703437793743, 4949.282354058713, 4956.727379994135, 5006.3992320921725, 3835.5780864104368, 3853.190829925747, 3857.3056849767313, 3857.8456861725217, 3882.398228274622, 5280.128778751463, 5280.339957505312, 5287.629865909349, 5300.337457817773, 5304.575633949352, 4992.926520798046, 5112.795488180431, 5145.331106956071, 5156.845294641017, 5194.558462530727, 5038.445770965118, 5085.872853178552, 5087.847364579068, 5099.439061703136, 5102.158143906362, 4977.676451030671, 4979.377577802775, 4995.125852975642, 5004.299398084198, 5024.648274620741, 4926.581240594446, 5098.41368242642, 5135.35808023997, 5148.665336753099, 5190.351206099238, 4974.776135073858, 4985.501449855131, 4993.575546078624, 5020.598352131894, 5023.899522009467], "value": 3832.0024141618665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.0541619867715, 594.9970250148749, 643.2859525926222, 654.6235914349248, 659.7822718502895, 11989.460474278656, 12246.755064898696, 12720.93639531801, 12873.356332183388, 12903.419346129424, 13305.46778128876, 13470.797938030937, 13474.595762127128, 13476.39356228972, 13479.460821567125, 764.9770506884788, 784.6704384158667, 785.2893131715806, 785.7485604606528, 786.3984052200071, 638.6200210874522, 745.057502259642, 776.4254451705725, 780.1963977103593, 783.9921600784005, 808.454293351988, 812.212154210415, 817.1746535998625, 818.758466252457, 819.8196396792696, 812.544974814106, 813.1543195077143, 813.259933460551, 813.686730608714, 813.7518056992615, 488.4675703483185, 496.94036715594, 501.22560643805406, 503.0643004012534, 578.4331355271815, 12579.308138052404, 13160.210387376788, 13213.0, 13214.207147571176, 13216.735665286737, 11505.827412588818, 11811.468483918245, 11824.467898944567, 12009.519619215222, 12062.939685301604, 10606.0, 10819.0, 10889.891101089046, 10904.182186335976, 10909.1818113641, 3808.9619103808886, 3837.7889216093104, 3900.0, 3902.9609703902884, 3920.3335432976464, 66870.66564667194, 68015.0, 69266.0, 69424.0, 69739.95390069204, 9373.343865929455, 9471.573779179953, 9485.383450075724, 9499.14507694297, 9502.857457138149, 16085.35658573644, 17321.91339043322, 17325.826741732675, 17339.13304334778, 17354.219060142324, 6384.553081284358, 6594.208694956636, 6802.489813264025, 6837.726490940406, 7059.082319298561, 3719.367707489733, 3749.512563366745, 3756.8121593920196, 3804.372278574004, 3900.4344370066183, 2704.8241864278757, 2801.089645865102, 2829.957550636742, 2830.5471124620376, 2832.7167283271506, 501.71653016045815, 503.61221859168234, 508.3899320815037, 511.8336540624312, 542.2814770429197, 555.5805366947928, 557.9637323573954, 568.7923907773633, 593.9627079118578, 604.1541841421956, 7850.136484986647, 7917.168697286817, 7938.166492518202, 8161.836763264701, 8180.550069746221, 510.81865937592363, 599.2240049136379, 602.1449541650866, 608.9573729838869, 611.9724612392453, 3713.2387860488534, 4065.7153999220363, 4096.938545921814, 4151.6886233532605, 4177.3316269396755, 76729.0, 102890.0, 104360.47819760852, 104903.0, 107624.0, 67350.66324668346, 75722.62138689382, 77566.0, 79923.60038199888, 81169.0, 66945.0, 67468.32531674621, 70871.91280871871, 71151.0, 71715.6414217936, 7549.811254718676, 8212.958935205286, 8433.451825631315, 8443.408961372645, 8465.407421480437, 31332.686673132976, 32124.83937580297, 35814.104647382985, 39314.94937581797, 39695.2060958785, 59241.70379148249, 59712.402875972424, 60743.0, 61249.0, 62203.0, 10853.728656783644, 11049.17131215146, 11166.944165279447, 11411.714707132389, 11448.94275528617, 11617.302961822317, 11628.18602697803, 11836.881631183578, 11907.583234586747, 12004.09969252327, 11384.203105782515, 11543.826842597537, 11906.940465297617, 12415.751684966432, 12421.503139874303, 10948.7408947972, 11402.315861048364, 11402.657920262405, 11473.13951453661, 11839.644810655695, 10492.422916739653, 10904.454777261264, 10941.617043403443, 11019.0, 11019.83470247963, 8997.775055623662, 9348.626054957726, 9605.615775369186, 9679.225661946886, 9863.112319891245, 9403.764905877408, 9649.469279189712, 9959.950200248952, 9971.900280997388, 9975.900240997496], "value": 6398.818603140023, "unit": "score"}], "name": "dromaeo_css", "value": 6380.622873432297, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 115.0, 115.0, 114.0, 113.0, 115.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 122.0, 180.0, 126.0, 124.0, 163.0, 129.0, 170.0, 121.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 116.0, 77.0, 76.0, 76.0, 77.0, 104.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 114.0, 86.0, 84.0, 85.0, 129.0, 84.0, 85.0, 136.0], "value": 97.5, "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, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 59.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 62.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 77.0, 77.0, 81.0, 78.0, 77.0, 78.0, 78.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 127.0, 130.0, 128.0, 127.0, 138.0, 126.0, 179.0, 130.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 166.0, 163.0, 165.0, 164.0, 164.0, 166.0, 164.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 68.0, 67.0, 70.0, 67.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1525.2, "alertThreshold": 2.0}]} 05:37:22 INFO - Return code: 0 05:37:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:22 INFO - # TBPL SUCCESS # 05:37:22 INFO - Running post-action listener: _resource_record_post_action 05:37:22 INFO - [mozharness: 2016-07-29 12:37:22.564887Z] Finished run-tests step (success) 05:37:22 INFO - Running post-run listener: _resource_record_post_run 05:37:22 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 10903552; Write bytes: 417558528; Read time: 2404; Write time: 400124 05:37:22 INFO - TinderboxPrint: CPU usage
13.0% 05:37:22 INFO - TinderboxPrint: I/O read bytes / time
10,903,552 / 2,404 05:37:22 INFO - TinderboxPrint: I/O write bytes / time
417,558,528 / 400,124 05:37:22 INFO - TinderboxPrint: CPU idle
8,343.5 (87.0%) 05:37:22 INFO - TinderboxPrint: CPU user
1,202.7 (12.5%) 05:37:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 94494720; Read time: 88; Write time: 75112 05:37:22 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8417280; Write bytes: 323063808; Read time: 1688; Write time: 325012 05:37:23 INFO - Running post-run listener: _upload_blobber_files 05:37:23 INFO - Blob upload gear active. 05:37:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:23 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 05:37:23 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'] 05:37:23 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 05:37:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:24 INFO - (blobuploader) - INFO - Done attempting. 05:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:28 INFO - (blobuploader) - INFO - Done attempting. 05:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:28 INFO - (blobuploader) - INFO - Done attempting. 05:37:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:28 INFO - Return code: 0 05:37:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bd6d9f9d00d37bf78648a6ee21268062a3666573e9d7db813c3feaf880af750ac038bf53685ae16a97d02453837cbc2818cd500b09d932e9017d29a74016c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9fc1fcbc58f4549d8edc69428327e7b02a79c6705d6196d67604d2ff00f77679d679ff4d4c58c62b0e7b4aeaf88ec8ea8db00e8b8b22b2f079dec948c7bbac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ffeaeb1cd8ab9641b05e7f3fae18f9ea93db765c335c25fc309386480bb9d54f82f824da883135a2d3161f37094233ca3d25ba349aed7ad6ee5986cd896d748"} 05:37:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:28 INFO - Contents: 05:37:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bd6d9f9d00d37bf78648a6ee21268062a3666573e9d7db813c3feaf880af750ac038bf53685ae16a97d02453837cbc2818cd500b09d932e9017d29a74016c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9fc1fcbc58f4549d8edc69428327e7b02a79c6705d6196d67604d2ff00f77679d679ff4d4c58c62b0e7b4aeaf88ec8ea8db00e8b8b22b2f079dec948c7bbac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ffeaeb1cd8ab9641b05e7f3fae18f9ea93db765c335c25fc309386480bb9d54f82f824da883135a2d3161f37094233ca3d25ba349aed7ad6ee5986cd896d748"} 05:37:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:28 INFO - Copying logs to upload dir... 05:37:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.382592 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-29 05:37:28.926691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 05:37:28.930559) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 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/31bd6d9f9d00d37bf78648a6ee21268062a3666573e9d7db813c3feaf880af750ac038bf53685ae16a97d02453837cbc2818cd500b09d932e9017d29a74016c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9fc1fcbc58f4549d8edc69428327e7b02a79c6705d6196d67604d2ff00f77679d679ff4d4c58c62b0e7b4aeaf88ec8ea8db00e8b8b22b2f079dec948c7bbac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ffeaeb1cd8ab9641b05e7f3fae18f9ea93db765c335c25fc309386480bb9d54f82f824da883135a2d3161f37094233ca3d25ba349aed7ad6ee5986cd896d748"} build_url:https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/TDA02KHcQ-Gxdq1g3h1ZkQ/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/31bd6d9f9d00d37bf78648a6ee21268062a3666573e9d7db813c3feaf880af750ac038bf53685ae16a97d02453837cbc2818cd500b09d932e9017d29a74016c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9fc1fcbc58f4549d8edc69428327e7b02a79c6705d6196d67604d2ff00f77679d679ff4d4c58c62b0e7b4aeaf88ec8ea8db00e8b8b22b2f079dec948c7bbac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ffeaeb1cd8ab9641b05e7f3fae18f9ea93db765c335c25fc309386480bb9d54f82f824da883135a2d3161f37094233ca3d25ba349aed7ad6ee5986cd896d748"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 05:37:28.955361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:37:28.955687) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469794599.318745-1967805114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:37:29.037785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 05:37:29.038080) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 05:37:29.038349) ========= ========= Total master_lag: 0.41 =========