builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1463689937.95 results: success (0) buildid: 20160519104245 builduid: 5a2af5b312aa445eb1a64a250eeabd9e revision: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:17.954617) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:17.955081) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:17.955355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:17.972556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:17.972924) ========= 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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 13:32:18-- 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% 224M=0s 2016-05-19 13:32:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:18.104031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:18.104341) ========= 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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014742 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:18.154526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 13:32:18.154863) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 --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 a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 --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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 13:32:18,391 truncating revision to first 12 chars 2016-05-19 13:32:18,392 Setting DEBUG logging. 2016-05-19 13:32:18,392 attempt 1/10 2016-05-19 13:32:18,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3eb9950fa4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 13:32:19,315 unpacking tar archive at: fx-team-a3eb9950fa4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 13:32:19.413452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:19.413782) ========= script_repo_revision: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:19.414177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:19.414441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 13:32:19.421657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-19 13:32:19.421930) ========= /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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:19 INFO - MultiFileLogger online at 20160519 13:32:19 in /builds/slave/test 13:32:19 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 13:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:19 INFO - {'append_to_log': False, 13:32:19 INFO - 'base_work_dir': '/builds/slave/test', 13:32:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:19 INFO - 'branch': 'Fx-Team-Non-PGO', 13:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:19 INFO - 'config_files': ('talos/linux_config.py',), 13:32:19 INFO - 'default_actions': ('clobber', 13:32:19 INFO - 'read-buildbot-config', 13:32:19 INFO - 'download-and-extract', 13:32:19 INFO - 'populate-webroot', 13:32:19 INFO - 'create-virtualenv', 13:32:19 INFO - 'install', 13:32:19 INFO - 'run-tests'), 13:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:19 INFO - 'download_minidump_stackwalk': True, 13:32:19 INFO - 'download_symbols': 'ondemand', 13:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:19 INFO - 'installer_path': 'installer.exe', 13:32:19 INFO - 'log_level': 'info', 13:32:19 INFO - 'log_name': 'talos', 13:32:19 INFO - 'log_to_console': True, 13:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:19 INFO - 'opt_config_files': (), 13:32:19 INFO - 'pip_index': False, 13:32:19 INFO - 'sps_profile': False, 13:32:19 INFO - 'sps_profile_interval': 0, 13:32:19 INFO - 'suite': 'dromaeojs', 13:32:19 INFO - 'system_bits': '32', 13:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:19 INFO - 'title': 'talos-linux64-ix-020', 13:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:19 INFO - 'use_talos_json': True, 13:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:19 INFO - 'work_dir': 'build'} 13:32:19 INFO - ##### 13:32:19 INFO - ##### Running clobber step. 13:32:19 INFO - ##### 13:32:19 INFO - Running pre-action listener: _resource_record_pre_action 13:32:19 INFO - Running main action method: clobber 13:32:19 INFO - rmtree: /builds/slave/test/build 13:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:20 INFO - Running post-action listener: _resource_record_post_action 13:32:20 INFO - ##### 13:32:20 INFO - ##### Finished clobber step (success) 13:32:20 INFO - ##### 13:32:20 INFO - ##### 13:32:20 INFO - ##### Running read-buildbot-config step. 13:32:20 INFO - ##### 13:32:20 INFO - Running pre-action listener: _resource_record_pre_action 13:32:20 INFO - Running main action method: read_buildbot_config 13:32:20 INFO - Using buildbot properties: 13:32:20 INFO - { 13:32:20 INFO - "project": "", 13:32:20 INFO - "product": "firefox", 13:32:20 INFO - "script_repo_revision": "production", 13:32:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:32:20 INFO - "repository": "", 13:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:32:20 INFO - "buildid": "20160519104245", 13:32:20 INFO - "pgo_build": "False", 13:32:20 INFO - "basedir": "/builds/slave/test", 13:32:20 INFO - "buildnumber": 2995, 13:32:20 INFO - "slavename": "talos-linux64-ix-020", 13:32:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:32:20 INFO - "platform": "ubuntu64_hw", 13:32:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:32:20 INFO - "branch": "fx-team", 13:32:20 INFO - "repo_path": "integration/fx-team", 13:32:20 INFO - "revision": "a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35", 13:32:20 INFO - "stage_platform": "linux64", 13:32:20 INFO - "builduid": "5a2af5b312aa445eb1a64a250eeabd9e", 13:32:20 INFO - "slavebuilddir": "test" 13:32:20 INFO - } 13:32:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:32:20 INFO - Running post-action listener: _resource_record_post_action 13:32:20 INFO - ##### 13:32:20 INFO - ##### Finished read-buildbot-config step (success) 13:32:20 INFO - ##### 13:32:20 INFO - ##### 13:32:20 INFO - ##### Running download-and-extract step. 13:32:20 INFO - ##### 13:32:20 INFO - Running pre-action listener: _resource_record_pre_action 13:32:20 INFO - Running main action method: download_and_extract 13:32:20 INFO - mkdir: /builds/slave/test/build/tests 13:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:20 INFO - https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:32:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:32:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:32:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:32:22 INFO - Downloaded 1361 bytes. 13:32:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:32:22 INFO - Using the following test package requirements: 13:32:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:32:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'jsshell-linux-x86_64.zip'], 13:32:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:22 INFO - https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:24 INFO - Downloaded 22813669 bytes. 13:32:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:32:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:32:25 INFO - Return code: 0 13:32:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:25 INFO - https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:26 INFO - Downloaded 22813669 bytes. 13:32:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:32:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:32:28 INFO - Return code: 0 13:32:28 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')]} 13:32:28 INFO - https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:32:30 INFO - Downloaded 10840359 bytes. 13:32:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:32:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:32:30 INFO - Return code: 0 13:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:30 INFO - https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:32:32 INFO - Downloaded 54809039 bytes. 13:32:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:32:32 INFO - mkdir: /builds/slave/test/properties 13:32:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:32 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:32 INFO - Contents: 13:32:32 INFO - build_url:https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:32:33 INFO - Running post-action listener: _resource_record_post_action 13:32:33 INFO - Running post-action listener: set_extra_try_arguments 13:32:33 INFO - ##### 13:32:33 INFO - ##### Finished download-and-extract step (success) 13:32:33 INFO - ##### 13:32:33 INFO - ##### 13:32:33 INFO - ##### Running populate-webroot step. 13:32:33 INFO - ##### 13:32:33 INFO - Running pre-action listener: _resource_record_pre_action 13:32:33 INFO - Running main action method: populate_webroot 13:32:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:33 INFO - '--tppagecycles', 13:32:33 INFO - '7'], 13:32:33 INFO - 'tests': ['tsvgm']}}, 13:32:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:32:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:32:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:32:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['damp', 'tps']}, 13:32:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'tests': ['damp', 'tps']}, 13:32:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['dromaeo_dom']}, 13:32:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'other-e10s': {'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['a11yr', 13:32:33 INFO - 'ts_paint', 13:32:33 INFO - 'tpaint', 13:32:33 INFO - 'sessionrestore', 13:32:33 INFO - 'sessionrestore_no_auto_restore', 13:32:33 INFO - 'tabpaint']}, 13:32:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['tsvgx', 13:32:33 INFO - 'tsvgr_opacity', 13:32:33 INFO - 'tart', 13:32:33 INFO - 'tscrollx', 13:32:33 INFO - 'cart']}, 13:32:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:32:33 INFO - 'tsvgr_opacity', 13:32:33 INFO - 'tart', 13:32:33 INFO - 'tscrollx', 13:32:33 INFO - 'cart']}, 13:32:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'talos_options': ['--disable-e10s'], 13:32:33 INFO - 'tests': ['tp5o']}, 13:32:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'tests': ['tp5o']}, 13:32:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'talos_options': ['--disable-e10s', 13:32:33 INFO - '--xperf_path', 13:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:33 INFO - 'tests': ['tp5n']}, 13:32:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:33 INFO - 'talos_options': ['--xperf_path', 13:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:33 INFO - 'tests': ['tp5n']}}, 13:32:33 INFO - 'talos.zip': {'path': '', 13:32:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:33 INFO - Running post-action listener: _resource_record_post_action 13:32:33 INFO - ##### 13:32:33 INFO - ##### Finished populate-webroot step (success) 13:32:33 INFO - ##### 13:32:33 INFO - ##### 13:32:33 INFO - ##### Running create-virtualenv step. 13:32:33 INFO - ##### 13:32:33 INFO - Running pre-action listener: _resource_record_pre_action 13:32:33 INFO - Running main action method: create_virtualenv 13:32:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:33 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 13:32:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:33 INFO - Using real prefix '/usr' 13:32:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:34 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:36 INFO - Installing pip.................done. 13:32:36 INFO - Return code: 0 13:32:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:36 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:36 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 13:32:36 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 13:32:36 INFO - Using env: {'DISPLAY': ':0', 13:32:36 INFO - 'HOME': '/home/cltbld', 13:32:36 INFO - 'LANG': 'en_US.UTF-8', 13:32:36 INFO - 'LANGUAGE': 'en_US:en', 13:32:36 INFO - 'LOGNAME': 'cltbld', 13:32:36 INFO - 'MAIL': '/var/mail/cltbld', 13:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:36 INFO - 'MOZ_NO_REMOTE': '1', 13:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:36 INFO - 'NO_EM_RESTART': '1', 13:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:36 INFO - 'PWD': '/builds/slave/test', 13:32:36 INFO - 'SHELL': '/bin/bash', 13:32:36 INFO - 'SHLVL': '1', 13:32:36 INFO - 'TERM': 'linux', 13:32:36 INFO - 'TMOUT': '86400', 13:32:36 INFO - 'USER': 'cltbld', 13:32:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:36 INFO - '_': '/tools/buildbot/bin/python'} 13:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:36 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 13:32:36 INFO - Cleaning up... 13:32:36 INFO - Return code: 0 13:32:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:36 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:36 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 13:32:36 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 13:32:36 INFO - Using env: {'DISPLAY': ':0', 13:32:36 INFO - 'HOME': '/home/cltbld', 13:32:36 INFO - 'LANG': 'en_US.UTF-8', 13:32:36 INFO - 'LANGUAGE': 'en_US:en', 13:32:36 INFO - 'LOGNAME': 'cltbld', 13:32:36 INFO - 'MAIL': '/var/mail/cltbld', 13:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:36 INFO - 'MOZ_NO_REMOTE': '1', 13:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:36 INFO - 'NO_EM_RESTART': '1', 13:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:36 INFO - 'PWD': '/builds/slave/test', 13:32:36 INFO - 'SHELL': '/bin/bash', 13:32:36 INFO - 'SHLVL': '1', 13:32:36 INFO - 'TERM': 'linux', 13:32:36 INFO - 'TMOUT': '86400', 13:32:36 INFO - 'USER': 'cltbld', 13:32:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:36 INFO - '_': '/tools/buildbot/bin/python'} 13:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:36 INFO - Downloading/unpacking psutil>=3.1.1 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:38 INFO - Installing collected packages: psutil 13:32:38 INFO - Running setup.py install for psutil 13:32:38 INFO - building 'psutil._psutil_linux' extension 13:32:38 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 13:32:39 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 13:32:39 INFO - building 'psutil._psutil_posix' extension 13:32:39 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 13:32:39 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 13:32:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:39 INFO - Successfully installed psutil 13:32:39 INFO - Cleaning up... 13:32:39 INFO - Return code: 0 13:32:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:32:39 INFO - Using env: {'DISPLAY': ':0', 13:32:39 INFO - 'HOME': '/home/cltbld', 13:32:39 INFO - 'LANG': 'en_US.UTF-8', 13:32:39 INFO - 'LANGUAGE': 'en_US:en', 13:32:39 INFO - 'LOGNAME': 'cltbld', 13:32:39 INFO - 'MAIL': '/var/mail/cltbld', 13:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:39 INFO - 'MOZ_NO_REMOTE': '1', 13:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:39 INFO - 'NO_EM_RESTART': '1', 13:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:39 INFO - 'PWD': '/builds/slave/test', 13:32:39 INFO - 'SHELL': '/bin/bash', 13:32:39 INFO - 'SHLVL': '1', 13:32:39 INFO - 'TERM': 'linux', 13:32:39 INFO - 'TMOUT': '86400', 13:32:39 INFO - 'USER': 'cltbld', 13:32:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:39 INFO - '_': '/tools/buildbot/bin/python'} 13:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:41 INFO - Installing collected packages: mozsystemmonitor 13:32:41 INFO - Running setup.py install for mozsystemmonitor 13:32:41 INFO - Successfully installed mozsystemmonitor 13:32:41 INFO - Cleaning up... 13:32:41 INFO - Return code: 0 13:32:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:41 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')]} 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 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')]} 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:41 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 13:32:41 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 13:32:41 INFO - Using env: {'DISPLAY': ':0', 13:32:41 INFO - 'HOME': '/home/cltbld', 13:32:41 INFO - 'LANG': 'en_US.UTF-8', 13:32:41 INFO - 'LANGUAGE': 'en_US:en', 13:32:41 INFO - 'LOGNAME': 'cltbld', 13:32:41 INFO - 'MAIL': '/var/mail/cltbld', 13:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:41 INFO - 'MOZ_NO_REMOTE': '1', 13:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:41 INFO - 'NO_EM_RESTART': '1', 13:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:41 INFO - 'PWD': '/builds/slave/test', 13:32:41 INFO - 'SHELL': '/bin/bash', 13:32:41 INFO - 'SHLVL': '1', 13:32:41 INFO - 'TERM': 'linux', 13:32:41 INFO - 'TMOUT': '86400', 13:32:41 INFO - 'USER': 'cltbld', 13:32:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:41 INFO - '_': '/tools/buildbot/bin/python'} 13:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:41 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 13:32:41 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 13:32:41 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 13:32:41 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 13:32:41 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 13:32:41 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 13:32:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 INFO - Downloading docopt-0.6.1.tar.gz 13:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:44 INFO - Running setup.py install for blobuploader 13:32:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:44 INFO - Running setup.py install for requests 13:32:44 INFO - Running setup.py install for docopt 13:32:45 INFO - Successfully installed blobuploader requests docopt 13:32:45 INFO - Cleaning up... 13:32:45 INFO - Return code: 0 13:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:45 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:45 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 13:32:45 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 13:32:45 INFO - Using env: {'DISPLAY': ':0', 13:32:45 INFO - 'HOME': '/home/cltbld', 13:32:45 INFO - 'LANG': 'en_US.UTF-8', 13:32:45 INFO - 'LANGUAGE': 'en_US:en', 13:32:45 INFO - 'LOGNAME': 'cltbld', 13:32:45 INFO - 'MAIL': '/var/mail/cltbld', 13:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:45 INFO - 'MOZ_NO_REMOTE': '1', 13:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:45 INFO - 'NO_EM_RESTART': '1', 13:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:45 INFO - 'PWD': '/builds/slave/test', 13:32:45 INFO - 'SHELL': '/bin/bash', 13:32:45 INFO - 'SHLVL': '1', 13:32:45 INFO - 'TERM': 'linux', 13:32:45 INFO - 'TMOUT': '86400', 13:32:45 INFO - 'USER': 'cltbld', 13:32:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:45 INFO - '_': '/tools/buildbot/bin/python'} 13:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:45 INFO - Running setup.py (path:/tmp/pip-8TW2aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:45 INFO - Running setup.py (path:/tmp/pip-Ta8hbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:45 INFO - Running setup.py (path:/tmp/pip-ZW_mHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:45 INFO - Running setup.py (path:/tmp/pip-IzpmkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:45 INFO - Running setup.py (path:/tmp/pip-uHEq2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:45 INFO - Running setup.py (path:/tmp/pip-q2T0R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:45 INFO - Running setup.py (path:/tmp/pip-3y5Sen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:45 INFO - Running setup.py (path:/tmp/pip-TViF9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:45 INFO - Running setup.py (path:/tmp/pip-DnXklP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:45 INFO - Running setup.py (path:/tmp/pip-esUsTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:45 INFO - Running setup.py (path:/tmp/pip-848wM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:46 INFO - Running setup.py (path:/tmp/pip-x16okj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:46 INFO - Running setup.py (path:/tmp/pip-6nybMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:46 INFO - Running setup.py (path:/tmp/pip-qnF_zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:46 INFO - Running setup.py (path:/tmp/pip-daowDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:46 INFO - Running setup.py (path:/tmp/pip-Rrzz8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:46 INFO - Running setup.py (path:/tmp/pip-r4PtFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:46 INFO - Running setup.py install for manifestparser 13:32:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:46 INFO - Running setup.py install for mozcrash 13:32:46 INFO - Running setup.py install for mozdebug 13:32:46 INFO - Running setup.py install for mozdevice 13:32:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:46 INFO - Running setup.py install for mozfile 13:32:47 INFO - Running setup.py install for mozhttpd 13:32:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozinfo 13:32:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozInstall 13:32:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozleak 13:32:47 INFO - Running setup.py install for mozlog 13:32:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for moznetwork 13:32:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozprocess 13:32:47 INFO - Running setup.py install for mozprofile 13:32:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozrunner 13:32:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Running setup.py install for mozscreenshot 13:32:48 INFO - Running setup.py install for moztest 13:32:48 INFO - Running setup.py install for mozversion 13:32:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:48 INFO - Cleaning up... 13:32:48 INFO - Return code: 0 13:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:48 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:48 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 13:32:48 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 13:32:48 INFO - Using env: {'DISPLAY': ':0', 13:32:48 INFO - 'HOME': '/home/cltbld', 13:32:48 INFO - 'LANG': 'en_US.UTF-8', 13:32:48 INFO - 'LANGUAGE': 'en_US:en', 13:32:48 INFO - 'LOGNAME': 'cltbld', 13:32:48 INFO - 'MAIL': '/var/mail/cltbld', 13:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:48 INFO - 'MOZ_NO_REMOTE': '1', 13:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:48 INFO - 'NO_EM_RESTART': '1', 13:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:48 INFO - 'PWD': '/builds/slave/test', 13:32:48 INFO - 'SHELL': '/bin/bash', 13:32:48 INFO - 'SHLVL': '1', 13:32:48 INFO - 'TERM': 'linux', 13:32:48 INFO - 'TMOUT': '86400', 13:32:48 INFO - 'USER': 'cltbld', 13:32:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:48 INFO - '_': '/tools/buildbot/bin/python'} 13:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:48 INFO - Running setup.py (path:/tmp/pip-i1nFu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:48 INFO - Running setup.py (path:/tmp/pip-rubhqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:48 INFO - Running setup.py (path:/tmp/pip-0ZXfyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:48 INFO - Running setup.py (path:/tmp/pip-IqdL2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:48 INFO - Running setup.py (path:/tmp/pip-LkSYQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:48 INFO - Running setup.py (path:/tmp/pip-pG4EC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:48 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)) 13:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:48 INFO - Running setup.py (path:/tmp/pip-q21eRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:49 INFO - Running setup.py (path:/tmp/pip-S8kdnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:49 INFO - Running setup.py (path:/tmp/pip-7gfZLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:49 INFO - Running setup.py (path:/tmp/pip-rvd6D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:49 INFO - Running setup.py (path:/tmp/pip-r2AC8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:49 INFO - Running setup.py (path:/tmp/pip-em7i8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:49 INFO - Running setup.py (path:/tmp/pip-yKEpI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:49 INFO - Running setup.py (path:/tmp/pip-ZG2pKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:49 INFO - Running setup.py (path:/tmp/pip-UmvF8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:49 INFO - Running setup.py (path:/tmp/pip-fkZDLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:49 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)) 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:49 INFO - Running setup.py (path:/tmp/pip-pi6qS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:49 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)) 13:32:49 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)) 13:32:49 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)) 13:32:49 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)) 13:32:49 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)) 13:32:49 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)) 13:32:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:51 INFO - Downloading blessings-1.6.tar.gz 13:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:51 INFO - Installing collected packages: blessings 13:32:51 INFO - Running setup.py install for blessings 13:32:51 INFO - Successfully installed blessings 13:32:51 INFO - Cleaning up... 13:32:51 INFO - Return code: 0 13:32:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:52 INFO - Reading from file tmpfile_stdout 13:32:52 INFO - Current package versions: 13:32:52 INFO - argparse == 1.2.1 13:32:52 INFO - blessings == 1.6 13:32:52 INFO - blobuploader == 1.2.4 13:32:52 INFO - docopt == 0.6.1 13:32:52 INFO - manifestparser == 1.1 13:32:52 INFO - mozInstall == 1.12 13:32:52 INFO - mozcrash == 0.17 13:32:52 INFO - mozdebug == 0.1 13:32:52 INFO - mozdevice == 0.48 13:32:52 INFO - mozfile == 1.2 13:32:52 INFO - mozhttpd == 0.7 13:32:52 INFO - mozinfo == 0.9 13:32:52 INFO - mozleak == 0.1 13:32:52 INFO - mozlog == 3.2 13:32:52 INFO - moznetwork == 0.27 13:32:52 INFO - mozprocess == 0.22 13:32:52 INFO - mozprofile == 0.28 13:32:52 INFO - mozrunner == 6.11 13:32:52 INFO - mozscreenshot == 0.1 13:32:52 INFO - mozsystemmonitor == 0.3 13:32:52 INFO - moztest == 0.7 13:32:52 INFO - mozversion == 1.4 13:32:52 INFO - psutil == 3.1.1 13:32:52 INFO - requests == 1.2.3 13:32:52 INFO - wsgiref == 0.1.2 13:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:52 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')]} 13:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:52 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')]} 13:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:52 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:52 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 13:32:52 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 13:32:52 INFO - Using env: {'DISPLAY': ':0', 13:32:52 INFO - 'HOME': '/home/cltbld', 13:32:52 INFO - 'LANG': 'en_US.UTF-8', 13:32:52 INFO - 'LANGUAGE': 'en_US:en', 13:32:52 INFO - 'LOGNAME': 'cltbld', 13:32:52 INFO - 'MAIL': '/var/mail/cltbld', 13:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:52 INFO - 'MOZ_NO_REMOTE': '1', 13:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:52 INFO - 'NO_EM_RESTART': '1', 13:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:52 INFO - 'PWD': '/builds/slave/test', 13:32:52 INFO - 'SHELL': '/bin/bash', 13:32:52 INFO - 'SHLVL': '1', 13:32:52 INFO - 'TERM': 'linux', 13:32:52 INFO - 'TMOUT': '86400', 13:32:52 INFO - 'USER': 'cltbld', 13:32:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:52 INFO - '_': '/tools/buildbot/bin/python'} 13:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 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)) 13:32:52 INFO - Cleaning up... 13:32:52 INFO - Return code: 0 13:32:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:52 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')]} 13:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:52 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')]} 13:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:52 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 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:52 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 13:32:52 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 13:32:52 INFO - Using env: {'DISPLAY': ':0', 13:32:52 INFO - 'HOME': '/home/cltbld', 13:32:52 INFO - 'LANG': 'en_US.UTF-8', 13:32:52 INFO - 'LANGUAGE': 'en_US:en', 13:32:52 INFO - 'LOGNAME': 'cltbld', 13:32:52 INFO - 'MAIL': '/var/mail/cltbld', 13:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:52 INFO - 'MOZ_NO_REMOTE': '1', 13:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:52 INFO - 'NO_EM_RESTART': '1', 13:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:52 INFO - 'PWD': '/builds/slave/test', 13:32:52 INFO - 'SHELL': '/bin/bash', 13:32:52 INFO - 'SHLVL': '1', 13:32:52 INFO - 'TERM': 'linux', 13:32:52 INFO - 'TMOUT': '86400', 13:32:52 INFO - 'USER': 'cltbld', 13:32:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:52 INFO - '_': '/tools/buildbot/bin/python'} 13:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:52 INFO - Downloading/unpacking jsonschema 13:32:52 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 13:32:52 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 13:32:52 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 13:32:52 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 13:32:52 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 13:32:52 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 13:32:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:54 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:54 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 13:32:54 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 13:32:54 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 13:32:54 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 13:32:54 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 13:32:54 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 13:32:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:54 INFO - warning: no files found matching '*.txt' 13:32:54 INFO - no previously-included directories found matching 'build' 13:32:54 INFO - no previously-included directories found matching 'dist' 13:32:54 INFO - no previously-included directories found matching '.git*' 13:32:54 INFO - Installing collected packages: jsonschema, functools32 13:32:54 INFO - Running setup.py install for functools32 13:32:54 INFO - warning: no files found matching '*.txt' 13:32:54 INFO - no previously-included directories found matching 'build' 13:32:54 INFO - no previously-included directories found matching 'dist' 13:32:54 INFO - no previously-included directories found matching '.git*' 13:32:54 INFO - Successfully installed jsonschema functools32 13:32:54 INFO - Cleaning up... 13:32:54 INFO - Return code: 0 13:32:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:54 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7a9487f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', '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 13:32:54 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', 'flake8'] in /builds/slave/test/build 13:32:54 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 flake8 13:32:54 INFO - Using env: {'DISPLAY': ':0', 13:32:54 INFO - 'HOME': '/home/cltbld', 13:32:54 INFO - 'LANG': 'en_US.UTF-8', 13:32:54 INFO - 'LANGUAGE': 'en_US:en', 13:32:54 INFO - 'LOGNAME': 'cltbld', 13:32:54 INFO - 'MAIL': '/var/mail/cltbld', 13:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:54 INFO - 'MOZ_NO_REMOTE': '1', 13:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:54 INFO - 'NO_EM_RESTART': '1', 13:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:54 INFO - 'PWD': '/builds/slave/test', 13:32:54 INFO - 'SHELL': '/bin/bash', 13:32:54 INFO - 'SHLVL': '1', 13:32:54 INFO - 'TERM': 'linux', 13:32:54 INFO - 'TMOUT': '86400', 13:32:54 INFO - 'USER': 'cltbld', 13:32:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:54 INFO - '_': '/tools/buildbot/bin/python'} 13:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:55 INFO - Downloading/unpacking flake8 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:57 INFO - no previously-included directories found matching 'docs/_build' 13:32:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:57 INFO - Running setup.py install for pep8 13:32:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:57 INFO - no previously-included directories found matching 'docs/_build' 13:32:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:57 INFO - Cleaning up... 13:32:58 INFO - Return code: 0 13:32:58 INFO - Running post-action listener: _resource_record_post_action 13:32:58 INFO - Running post-action listener: _start_resource_monitoring 13:32:58 INFO - Starting resource monitoring. 13:32:58 INFO - ##### 13:32:58 INFO - ##### Finished create-virtualenv step (success) 13:32:58 INFO - ##### 13:32:58 INFO - ##### 13:32:58 INFO - ##### Running install step. 13:32:58 INFO - ##### 13:32:58 INFO - Running pre-action listener: _resource_record_pre_action 13:32:58 INFO - Running main action method: install 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Output received: 13:32:58 INFO - Usage: mozinstall [options] installer 13:32:58 INFO - Options: 13:32:58 INFO - -h, --help show this help message and exit 13:32:58 INFO - -d DEST, --destination=DEST 13:32:58 INFO - Directory to install application into. [default: 13:32:58 INFO - "/builds/slave/test"] 13:32:58 INFO - --app=APP Application being installed. [default: firefox] 13:32:58 INFO - mkdir: /builds/slave/test/build/application 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:33:14 INFO - Reading from file tmpfile_stdout 13:33:14 INFO - Output received: 13:33:14 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:14 INFO - Running post-action listener: _resource_record_post_action 13:33:14 INFO - ##### 13:33:14 INFO - ##### Finished install step (success) 13:33:14 INFO - ##### 13:33:14 INFO - ##### 13:33:14 INFO - ##### Running run-tests step. 13:33:14 INFO - ##### 13:33:14 INFO - Running pre-action listener: _resource_record_pre_action 13:33:14 INFO - Running main action method: run_tests 13:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:14 INFO - Python 2.7.3 13:33:14 INFO - Return code: 0 13:33:14 INFO - grabbing minidump binary from tooltool 13:33:14 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')]} 13:33:14 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 0x12649c0>, '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 0x12658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:14 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 13:33:14 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 13:33:14 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 13:33:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:14 INFO - Return code: 0 13:33:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:33:15 INFO - Return code: 0 13:33:15 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/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:33:15 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/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 13:33:15 INFO - Using env: {'DISPLAY': ':0', 13:33:15 INFO - 'HOME': '/home/cltbld', 13:33:15 INFO - 'LANG': 'en_US.UTF-8', 13:33:15 INFO - 'LANGUAGE': 'en_US:en', 13:33:15 INFO - 'LOGNAME': 'cltbld', 13:33:15 INFO - 'MAIL': '/var/mail/cltbld', 13:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:15 INFO - 'MOZ_NO_REMOTE': '1', 13:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:15 INFO - 'NO_EM_RESTART': '1', 13:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:15 INFO - 'PWD': '/builds/slave/test', 13:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:15 INFO - 'SHELL': '/bin/bash', 13:33:15 INFO - 'SHLVL': '1', 13:33:15 INFO - 'TERM': 'linux', 13:33:15 INFO - 'TMOUT': '86400', 13:33:15 INFO - 'USER': 'cltbld', 13:33:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245', 13:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:15 INFO - '_': '/tools/buildbot/bin/python'} 13:33:15 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/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:33:16 INFO - mozversion application_buildid: 20160519104245 13:33:16 INFO - mozversion application_changeset: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 13:33:16 INFO - mozversion application_display_name: Nightly 13:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:16 INFO - mozversion application_name: Firefox 13:33:16 INFO - mozversion application_remotingname: firefox 13:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:33:16 INFO - mozversion application_vendor: Mozilla 13:33:16 INFO - mozversion application_version: 49.0a1 13:33:16 INFO - mozversion platform_buildid: 20160519104245 13:33:16 INFO - mozversion platform_changeset: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 13:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:33:16 INFO - mozversion platform_version: 49.0a1 13:33:16 INFO - using testdate: 1463689996 13:33:16 INFO - actual date: 1463689996 13:33:16 INFO - starting webserver on 'localhost:58958' 13:33:16 INFO - SUITE-START | Running 2 tests 13:33:16 INFO - TEST-START | dromaeo_css 13:33:16 INFO - operating with platform_type : linux_ 13:33:16 INFO - Initialising browser for dromaeo_css test... 13:33:16 INFO - TEST-INFO | started process 29993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgOxDR/profile http://localhost:58958/getInfo.html) 13:33:21 INFO - PROCESS | 29993 | __metrics Screen width/height:1600/1200 13:33:21 INFO - PROCESS | 29993 | colorDepth:24 13:33:21 INFO - PROCESS | 29993 | Browser inner width/height: 1024/697 13:33:21 INFO - PROCESS | 29993 | __metrics 13:33:22 ERROR - PROCESS | 29993 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:33:23 INFO - TEST-INFO | 29993: exit 0 13:33:23 INFO - Browser initialized. 13:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:23 INFO - TEST-INFO | started process 30071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgOxDR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:35 INFO - PROCESS | 30071 | RSS: Main: 154558464 13:33:35 INFO - PROCESS | 30071 | 13:34:26 INFO - PROCESS | 30071 | 1463690066705 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] 13:36:38 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58958/tests/dromaeo/cssquery-ext.html) 13:36:39 INFO - PROCESS | 30071 | RSS: Main: 236498944 13:36:39 INFO - PROCESS | 30071 | 13:39:41 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-ext.html (next: http://localhost:58958/tests/dromaeo/cssquery-jquery.html) 13:39:42 INFO - PROCESS | 30071 | RSS: Main: 239505408 13:39:42 INFO - PROCESS | 30071 | 13:42:44 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58958/tests/dromaeo/cssquery-mootools.html) 13:42:44 INFO - PROCESS | 30071 | RSS: Main: 242184192 13:42:44 INFO - PROCESS | 30071 | 13:45:47 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58958/tests/dromaeo/cssquery-prototype.html) 13:45:47 INFO - PROCESS | 30071 | RSS: Main: 243343360 13:45:47 INFO - PROCESS | 30071 | 13:48:50 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58958/tests/dromaeo/cssquery-yui.html) 13:48:51 INFO - PROCESS | 30071 | RSS: Main: 216612864 13:48:51 INFO - PROCESS | 30071 | 13:51:53 INFO - PROCESS | 30071 | Cycle 1(1): loaded http://localhost:58958/tests/dromaeo/cssquery-yui.html (next: http://localhost:58958/tests/dromaeo/cssquery-dojo.html) 13:51:54 INFO - PROCESS | 30071 | RSS: Main: 287916032 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | __start_tp_report 13:51:54 INFO - PROCESS | 30071 | _x_x_mozilla_page_load 13:51:54 INFO - PROCESS | 30071 | _x_x_mozilla_page_load_details 13:51:54 INFO - PROCESS | 30071 | |i|pagename|runs| 13:51:54 INFO - PROCESS | 30071 | |0;dojo.html;2644.6033095035746;2651.032373183786;2683.0072873036966;2688.045743760965;2690.0046982616436;4610.377599024131;4637.327587499811;4682.719036857791;4705.2942058691215;4784.760761961906;4640.883977900554;4657.231556793134;4669.089527542131;4676.438827340716;4688.882777930554;4092;4210.6631469482445;4343.348497725335;4370.344448332759;4443.066955939256;4348.934765978513;4383.430154079981;4397.604215620593;4404.4054052702795;4425.513193548723;4234.089670720809;4275.935860962088;4276.123394704078;4291;4321.308590625516;4222.767747773872;4228.534861165269;4236.851710190129;4271.508776490712;4279.251131052053;4271.722338048017;4297.247981603207;4303.763293018914;4328.5238623751675;4328.761918094504;4450.599446049839;4539.16025535277;4571.702839315434;4593;4599.655025873039;4946.332245146895;5003;5006.3241462402475;5052.646314757969;5060.114479965991;4959.404871415417;5011.098002359574;5018.89962200754;5024.899502009976;5036.672616279967;4503.031848152663;4608.377868987711;4701.600363969101;4704.458987216514;4771.33201351811;5110.105731496973;5142.485751424828;5147.562457191106;5159.097157997336;5192.662476938987;4774.4509381420885;4888.584470320063;4897.926531102036;4938.827141050046;4947;4894.363732714724;4965.478624744422;4980.900381992412;4982.950170498321;5007.474215207423;4944.406671199407;4950.331705219749;4962.528559786814;4986.376702912136;5020.849374518771;4899.975500122477;4900.509949005071;4955.950440495621;4973.278874563241;5021.49785021495;4265.296226122655;4270.551592082787;4288.120935208275;4328.653707703376;4329.242382583036;3728.7762734236035;3745.082454798537;3748.6251374862295;3759.5300587426573;3773.1887644156636;4250.3199488081755;4300.311950087971;4306.676999225071;4312.611864932172;4341.110072435144;4926.187179115406;4988.55103040728;5036.6726162799305;5037.5214354636255;5057.039162559102;4305.784710764449;4306.935395969063;4315.1585440838735;4317.589828966243;4363.934540981824;4465.441819772528;4489.304157855538;4534.841280555164;4559.954400456019;4564.817407303737;4676.859694209111;4702.670813043054;4711.952880471152;4726.503717109723;4729.456112546964;4997.85006449807;5010.398752149766;5013.874653133555;5016.147254966591;5075.999999999853;4596;4680.742559159279;4690.835820746258;4705.082508910729;4710.481846996896;4913;4921.729304888266;4926;4931;4981.302617633607;5005.374328208974;5012.47369026247;5018.673786203885;5018.749062546931;5026.220935754964;4795.736234507136;4827.903441931212;4879.975600121977;4893.266010098514;4914.238293064581;4878.731669758197;4882.36529251195;4891.095147397743;4899.681520701143;4935.4570997190995;4688.859334219979;4809.519048095302;4826.6621336506105;4885;4887.022595480847;4914.041761856547;4955.5044495550155;4957.206846904478;4972.403311602631;4973.602111831117;4788.569028787426;4816.277558366273;4819.49395313487;4820.638452116175;4863.392075990501 13:51:54 INFO - PROCESS | 30071 | |1;ext.html;586.818086393218;597.596622279961;607.4381197392411;607.6900780601892;615.7198474694012;40288.79855600721;41802.163956720884;41893.581064189384;45810.312845307264;45877.541224587745;41303;41830.163396732045;41880.581194188046;41896.58103418972;41945.16109677804;7587.506812057212;7665.1951545087795;7679.923200768005;7706.190849960757;7706.422018348619;7766.339861111812;7860.646270917822;7869.449138560303;7874.409419293547;7891.092524359686;7895.447318687694;7929.1277959424415;7936.285734283913;7940.364770818321;7948.9602551987155;7825.647845846951;7837.6864925402915;7873.409494287951;7895.644695988694;7909.881351779757;7837.725679601243;7924.366050715929;7924.524528528307;7925.643346049442;7929.563873986928;38950.61049389498;39442.60557394418;39477.60522394768;39539.40690889639;39615;2947.30738276507;2984.880604775806;3037.878484860625;3067.2485241115846;3142.3244002539336;29622.555661665094;29864.8506757467;29900.700992990227;31074.223144421343;31076.844615777;3416.2484253464445;3525.1715846775987;3531.5762108546883;3553.3248682750195;3575.76757510761;265686;269060.999999998;270428;270587;271259;53936.73031634895;53990.730046350305;54370.72814635901;54498.455015450134;54580.72709636506;49494.50505494899;55608.721956389956;58029.12956305659;58241;62846;12871.678208044874;13046.673833154056;13064.608061758163;13068.607941761762;13088.214707117604;9073.682421115229;9944.055314745088;10031.598736050622;10093.545790439448;10103.090721834924;15743.44897928567;16109.436169734237;16228.188590570424;16346.75479867803;16622;5775.5090817281;5784.421557844182;5816.565979329988;5910.438508341701;5940.70296485174;833.629035079396;877.0396415924553;923.3121324613072;943.9905600943903;990.6136606723384;27405.72594274032;28523.57214641782;28878.133655990354;28981.7101828979;28984.565231521545;914.5490086567929;970.684527528556;1029.9288739710616;1062.6333914799382;1103.167108832826;13978.231197284043;14390.83401651635;14767.080279563588;14783.778243326358;14925.477608283658;369726;371483;373278;373572;374016;51328.23007654888;51424.48575514197;51702.22446663303;51809;51858.74070629698;1020.1175982774995;1180.9822852657217;1242.0622430065243;1245.1719606461602;1246.9127161098818;27701.30746731348;28758.281042974093;29093.272668183465;29356.396096002292;29592.704072959856;41432;42100.36849447199;42141;42162;42226.36660450034;292639;296218;297047;297646;298154;22924.885375573016;23776.52446951017;24277.807037592847;24614.753852461246;24680.629790552797;41689.58310416857;41945;41979.1604167921;42120.78939605282;42518.362224567274;35590.28819423545;35637.64362356447;35834.28331433409;36057.819710901276;36294.637053630184;35232.823835880656;35765.40755467197;35804.28391432209;36023.63976360203;36246.27507449783;34808.30383392369;34856.302873942885;35278;35569;35574;31401.8429907849;32525.512117318733;32576.34847302993;32587.511187331736;32711.509327360585;24614.87692561526;25218.24345269645;25303.493930121662;25311.36721581975;25785.484290314464 13:51:54 INFO - PROCESS | 30071 | |2;jquery.html;372.56410000299655;378.60814057450534;383.47463974355156;392.94105884117397;397.8170041780781;15829.366825326988;16448.917755411236;17295.221715022824;17356.999999999967;17388.826111738865;14668.779968300483;14834.777478337834;15350.769738453931;15439.382424702999;15455.69088618227;4995.375578052753;5159.664621799571;5184.274201611777;5215.40022897366;5221.425643179247;3650.981745091284;3907.785071821049;5754.856128596798;6072.119542666311;6084.908726369108;6037.637741735488;6123.7244324005305;6127.47916427102;6143.1092491588915;6155.076738489218;5922.763089476416;6043.6675982820925;6056.606320589148;6119.6328220306705;6130.724117414705;3357.211055402003;4954.603631709455;5240.9475905241225;5264.947350526522;5310.6813591184655;19422.80577194224;19770.308039218704;20082.69875951862;20094.296699615443;20353;1869.3457289948544;1981.9702704459444;2168.793964573363;2219.700340454034;2339.7075365579303;12931.612051638465;12970;13140.86859131406;13228.801567976392;13510.527131550447;1734.3062774890018;1759.9120043997877;1799.8650101242458;1845.6954602490573;1852.1572684428552;64680;64735.3526464734;65127.348726513075;66320.00519992253;67262.3273767261;9398.248140148771;9412.67055653049;9749.853752193723;9854.950725246472;9908.554115064839;13433;13501.189928604119;13514.189148651112;13535.32323383827;13552.254625995665;6658.567193132528;6678.198616166092;6741.426978706767;6900.827479313058;6936.271691472423;6195.101710251988;6305.243370795534;6308.432241098231;6329.715162817684;6376.29860715321;6036.426539478743;6065.848353791191;6100.938990610126;6143.938560614426;6298.779542715983;1595.813735182807;1664.1512828457574;1725.30125299254;1798.694221982266;1832.8442082423144;864.9870251946226;885.4156256870434;901.8376692195336;931.8928323242914;1000.9549570269355;16215;16857.57856053584;16867.746983795252;17184.226709798088;17312.9612223267;858.4806192253722;870.9825803483894;871.2724874729545;871.930245580352;876.4434584039053;8896.332775041898;9983.15143212835;10139.695809125738;10219.948900255451;10276.332038417479;400985;402789;412559.0580706459;414195;416979;74733.626331868;78843.21156788473;78896.6055169732;80408.3305838009;81086;934.6168071090956;938.1790932933683;942.3215284994793;943.2642538819595;952.2667545989688;15468.690626187637;15485.535433937;15530.922345388653;15610.45363412275;15909.840901590836;34779.30441391208;36005.63994360128;36383.45424818577;36836.26327473382;37466.25067498689;48518;51046.48953510566;51456.74271628618;51474;51599;4557.498675145665;4683.110209060268;4736.289556566542;6819.897701534382;7543.811404714926;11296.6046188383;11296.774064518828;11401;11771.88228117742;11902.345371004332;7007.509474336747;9982.251331150048;10106.747331316776;10169.389836609827;10252.538635761557;10023.44871032071;10154.39073655583;10296.536655850654;10326.896731032593;10446.582136714447;10114.140298074451;10324.845127322946;10375.429351385746;10432.426216557858;10480.318779279323;6442.516811239082;6818.795436136924;6989.266127056586;7130;7550.244975502405;7625.123110842324;9192.586333615138;10288.897111028793;10305.282981464725;10324.07083362501 13:51:54 INFO - PROCESS | 30071 | |3;mootools.html;1312.875276848699;1442.2860683961442;1453.208001639107;1605.6949179655865;1792.8476079533239;6538.248101468333;7597.202293759158;7753.302202801747;7807.453478256524;7961.76114716558;7711.344535714457;7873.055233372003;7874.645640946157;7879.251471110249;7879.369650427966;1870.4575673054867;2099.2023031248104;2158.902849371774;2175.1516908405733;2181.1166477576608;2179.574982878339;2194.4623567226054;2196.5716685246384;2200.3618950504333;2200.482886521666;2158.179891641174;2181.149351752818;2206.2829580386438;2206.8124209442217;2207.1612787140944;1840.74229607855;2082.4897900014444;2130.4141361125658;2159.805617494417;2160.967585486219;2172.391730315514;2175.2495389090736;2194.3526659635445;2195.2645863635703;2199.516106456593;7915.485493442908;7976.561289129096;7984.401169912222;7991.760247192536;8007.799805004864;4305.203537345601;4410.62509686677;4428.092241090569;4435.68950173488;4440.533743956903;2841.6305880235436;2858.2425657200856;2907.8400687962153;2946.6905974872543;2962.7777916656337;893.0489029183898;908.5956749246587;911.6717981526646;913.3287034029983;917.6512925088424;10668.733281667943;10675.199360048027;10683.30558513694;10689.30519516229;10715.30350527221;4193.916121677549;4236.110416812442;4297.39836422901;4309.978450107729;4352.129574085196;9202;9237.630494780133;9245.676401326056;9261.72214833556;9269.304802139866;4553.408056952641;4559.202139625552;4561.566651168134;4563.589276965089;4577.404937358188;3476.66971637694;3836.5971572984995;3945.11234972129;3956.940645890314;3983.64147226751;3559.555055618048;3621.0766254604905;3669.6697297243377;3691.796951167658;3701.1672373715696;1172.3762588814552;1172.6130376975577;1180.3272134883034;1184.2006645514243;1189.7025743564109;724.9456290778213;742.3319012888444;760.8820632801925;854.6367793687658;900.8333458310234;5207.21891716238;5322.574194064466;5344.866378340573;5375.489328513785;5408.053590621704;814.0678922633551;877.5436772878068;908.4912449028565;917.6833992272656;924.4822899176482;3497.965020349815;3607.575007871876;3706.054955986206;3731.7201209909367;3733.738638295293;9421;9776.484644880054;9782.41305521671;9784.461854598065;9802.607895684092;9575.521223938775;9722.854157187649;9730.902690973;9732.07545283197;9732.2214222862;7001;7125.89311160333;7137.821554461076;7365.189829118793;7462.888056679154;5112.130937740519;5282.128448805904;5328.49379308965;5328.8934221314585;5392.164214546751;8514.48913065218;8854.335924805537;8927.285817134743;8941.418807777474;9024.684136055206;9070.81858362816;9236.676716314896;9260.981292057733;9278.11857873501;9313.720588382359;6034.39656034393;6422.6467544285515;6555.4427873629365;6639.2696803352555;6778.694958726967;7660.310572048543;7704.229577042251;7744.7676569703;7757.573333466714;7772.106207785951;6641.933580664325;6811.829704257433;6828.00993855898;6907.965460172667;6924.307569243036;6613.404793568602;6682.599044057372;6782.220044694726;6881.759138430131;6882.449404047764;6238.812835614939;6259.311475737756;6311.422144463884;6335.1130841683125;6346.841328966812;4707.905841883212;4741.952580474152;4788.11419887322;4842.491538388559;4847.103285892122;4713.622910167247;4755.476897541199;4778.952210477851;4824.614030877591;4892.31507588945 13:51:54 INFO - PROCESS | 30071 | |4;prototype.html;274.05178083829946;280.68219708468746;281.2406502443403;284.6740482147941;291.87157650633725;4700.482946875845;4759.999999999995;4782.545658162478;4796.712197268166;4798.280257961307;4706.69406488578;4728.872007596587;4752.857414277569;4773.284007398892;4774.188387974044;3555.8044307563073;3657.76224545405;3680.7485454945313;3778.716596255278;3788.7916164610933;3727.2918145552394;3747.550293964728;3766.114962983697;3778.981105094471;3786.469894214812;3563.5723713154457;3702.796591107901;3710.295043941656;3721.5162028936334;3734.9813250933844;3587.8564857405804;3738.3831667774784;3742.9064273393246;3751.0809851586537;3775.8112094395447;3313.3042061167184;3324.817135057571;3331.2171639664903;3339.3655205510877;3356.5329482830102;4588.220002599533;4588.646349326957;4589.2657174851865;4592.816287348502;4604.6776725629215;4199.265128602482;4237.859880760197;4303.63419109373;4328.069465064995;4333.873192969819;4970.601018099009;4989.476105008995;5025.874353141164;5027.120253955543;5048.116579598593;3638.5815631202486;3641.3445579795625;3659.8170091495317;3660.8352624131976;3666.120131168527;4966.50334966504;5179.81870634526;5195.3246078009615;5251.737413129328;5262.342207224097;3690.944635830465;3718.401087532387;3719.814009299524;3721.3997980868485;3726.8136593170234;3780.3177585973976;3784.1863999240295;3805.562360328542;3808;3808.6000969898314;4256.446661933991;4291.570842915684;4298.333758267474;4301.032267739796;4314.7626880521875;4754.762261886961;4940.728259945738;4966.677165984272;4983.975080124649;5032.748362581856;1289.8903593194495;1306.8173303160654;1314.9802752958713;1321.1610627251764;1323.245749922554;851.2806678356778;856.2978357746588;886.1714297132202;902.41794042842;915.839728047589;4338.501072376654;4387.605115539617;4392.934105988349;4395.956040439619;4402.801873915681;5037.168867136955;5039.79840806371;5057.266696329012;5118.38579370478;5140.228965655107;4253.170631726845;4305.332673435622;4360.672949528798;4369.868903932887;4382.693211475166;2703.8783254753585;2709.5368501009234;2713.7150599186803;2727.809053366285;2734.1934129431866;4770.212914869077;4796;4801.68789028712;4822.807087716452;4831.613470922318;5084.7966081356335;5214.165733482625;5216.869578260574;5221.086309895753;5263.36839579253;4796.664233503691;4803.975980120077;4805.663603547718;4811.133995880705;4813.181759100961;5009.423916249532;5012.548870601663;5044.974775126101;5055.443901170795;5062.31658726082;4690.249560070509;4973.801047958041;5006.299118123393;5026.773795179152;5053.67151135175;4722.803896188151;4747.786349614206;4793.4247890252;4795.544423279783;4802.975985120052;3724.6647801697977;3729.757565758217;3734.2718169956597;3734.9439758404187;3738.5139931809776;4862.41651001882;5051.318072060225;5061.848144555669;5136.666116702402;5139.203423469218;4837.322774811459;4867.1969125095375;4874.392200172891;4887.951120488749;4896.1921282987905;4911.140550403737;4923.258323674105;4931.235658472942;4948.158813001726;4949.752512374439;4694;4846.5153484651255;4876.171050921423;4901.2893130496595;4937.604991600591;4857.732824694675;4935.840077581694;4986.002799440054;4993.4756850530175;5013.799448022184;4879.902401952012;4894.486078961658;4917.188663870565;4969.801207951786;4974.9502504975935 13:51:54 INFO - PROCESS | 30071 | |5;yui.html;620.0791824141153;632.3834261594942;655.8524332025294;730.8926975631919;741.9777406677802;11215.719607009829;11236.101111911048;11248.38133902636;11536.423178841056;11909.106816988739;13558.30521184852;14107.224102674374;14133.929330353334;14143.575692729235;14150.858491415109;631.3181763695221;786.1509569664777;798.5248776977718;810.8864758933754;811.0834756724893;800.8478389106081;801.8155824160447;805.9113497515268;806.3146325623233;808.1474044882647;833.4874052457756;838.7944953486405;841.4530555139178;841.5119230846094;841.6128580852815;662.2913482573672;827.3877330775243;837.8533756592602;838.1995194589183;851.7019043334845;607.2470137030051;608.333874407523;610.4231501231338;611.0284647410595;611.1474493082126;11780.116491263103;11874.584389546411;11878.524859005629;11885.049196064381;11893.226940248856;12552.372381380894;13080.476780928846;13131.671708207276;13157.60527184186;13338.866611333859;9577.185939195177;9652.22782177424;9709.951450242774;9786.580945762897;9801.705948821547;3334.1831251343574;3347.715444187247;3413.6586341365914;3465.480177973299;3478.252175782219;43081.56918430807;43286.78356608228;44794.77602611999;45780.542194578295;45845.54154458446;9892.653757118467;9893.554790034466;9944.30389872702;10264.897351026544;10495.370277783357;17591.472255832345;17662.646747064988;17671.469855904343;17680.55798605045;17690.823091769176;6332.176817013758;6568;6632.4694024478895;6634.502412318999;6637.933620663732;3557.128503516655;3589.4436362363876;3615.204654975901;3665.321915445651;3676.062604036007;2633.144228125867;2726.291164297257;2729.3176705823544;2732.0437846753475;2732.8496932668495;477.9259214821708;490.2885159343804;493.20347638563464;500.2721040885503;508.3061620887536;476.440182785226;523.4922125538221;580.8286555466148;589.4311988930702;595.2618752746649;7577.128630207487;7695.345895598824;7701.537907725555;7891.131975482693;7898.210178982055;469.7463369780349;509.86998315429327;515.6519349439113;557.2783245696751;601.9367966363557;3671.7796932184156;3846.5576458707606;3892.6885849132;3927.8625248116177;3966.208618991213;52776.736116319174;53093.203601946;53947.73026134844;53955.19067213995;54023.729881350344;49378.50621493811;49879.50120498821;50317.49682503128;50772;51174.23238651423;45133.54866451359;45852.77073614678;45896;46150.53849461462;46438.76780616075;7704.383649308154;7754.689812407666;7867.724629637935;7908.1581830860105;7914.841703165789;30340.393192136475;30423.54364684576;30582.235444114074;31292.374152516368;31719.207019823767;36210.818945906154;37110;37375;39434.80282598569;40678.38982415207;10398.27212095146;10427;10447.373157610567;10643.680689579325;10687.839682404614;11205.719857003314;11279.605213817476;11511.94244028808;11518.596849110241;11597.768044638891;10558.524866381185;10725.570977160825;10816;10945.507452164513;11265.71835704114;10949.726256843642;11234.269772464764;11316.547338106384;11392.886071139183;11454.255473394203;10654.520546575577;10840.241183117107;11019;11040.558377665126;11352.091832653534;9327.76133727914;9354.298427618092;9471.763205919908;9507.66723164686;9765.951170244103;8571.614277357408;8951.865722014045;9134.954325228331;9175.632974680939;9211.815763684823 13:51:54 INFO - PROCESS | 30071 | __end_tp_report 13:51:54 INFO - PROCESS | 30071 | __start_cc_report 13:51:54 INFO - PROCESS | 30071 | _x_x_mozilla_cycle_collect,946 13:51:54 INFO - PROCESS | 30071 | __end_cc_report 13:51:54 INFO - PROCESS | 30071 | __startTimestamp1463691114065__endTimestamp 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | ------- Summary: start ------- 13:51:54 INFO - PROCESS | 30071 | Number of tests: 6 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#0] dojo.html Cycles:165 Average:4624.84 Median:4726.50 stddev:473.95 (10.0%) stddev-sans-first:449.22 13:51:54 INFO - PROCESS | 30071 | Values: 2644.6 2651.0 2683.0 2688.0 2690.0 4610.4 4637.3 4682.7 4705.3 4784.8 4640.9 4657.2 4669.1 4676.4 4688.9 4092.0 4210.7 4343.3 4370.3 4443.1 4348.9 4383.4 4397.6 4404.4 4425.5 4234.1 4275.9 4276.1 4291.0 4321.3 4222.8 4228.5 4236.9 4271.5 4279.3 4271.7 4297.2 4303.8 4328.5 4328.8 4450.6 4539.2 4571.7 4593.0 4599.7 4946.3 5003.0 5006.3 5052.6 5060.1 4959.4 5011.1 5018.9 5024.9 5036.7 4503.0 4608.4 4701.6 4704.5 4771.3 5110.1 5142.5 5147.6 5159.1 5192.7 4774.5 4888.6 4897.9 4938.8 4947.0 4894.4 4965.5 4980.9 4983.0 5007.5 4944.4 4950.3 4962.5 4986.4 5020.8 4900.0 4900.5 4956.0 4973.3 5021.5 4265.3 4270.6 4288.1 4328.7 4329.2 3728.8 3745.1 3748.6 3759.5 3773.2 4250.3 4300.3 4306.7 4312.6 4341.1 4926.2 4988.6 5036.7 5037.5 5057.0 4305.8 4306.9 4315.2 4317.6 4363.9 4465.4 4489.3 4534.8 4560.0 4564.8 4676.9 4702.7 4712.0 4726.5 4729.5 4997.9 5010.4 5013.9 5016.1 5076.0 4596.0 4680.7 4690.8 4705.1 4710.5 4913.0 4921.7 4926.0 4931.0 4981.3 5005.4 5012.5 5018.7 5018.7 5026.2 4795.7 4827.9 4880.0 4893.3 4914.2 4878.7 4882.4 4891.1 4899.7 4935.5 4688.9 4809.5 4826.7 4885.0 4887.0 4914.0 4955.5 4957.2 4972.4 4973.6 4788.6 4816.3 4819.5 4820.6 4863.4 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#1] ext.html Cycles:180 Average:47072.87 Median:203010.32 stddev:83002.62 (40.9%) stddev-sans-first:83162.08 13:51:54 INFO - PROCESS | 30071 | Values: 586.8 597.6 607.4 607.7 615.7 40288.8 41802.2 41893.6 45810.3 45877.5 41303.0 41830.2 41880.6 41896.6 41945.2 7587.5 7665.2 7679.9 7706.2 7706.4 7766.3 7860.6 7869.4 7874.4 7891.1 7895.4 7929.1 7936.3 7940.4 7949.0 7825.6 7837.7 7873.4 7895.6 7909.9 7837.7 7924.4 7924.5 7925.6 7929.6 38950.6 39442.6 39477.6 39539.4 39615.0 2947.3 2984.9 3037.9 3067.2 3142.3 29622.6 29864.9 29900.7 31074.2 31076.8 3416.2 3525.2 3531.6 3553.3 3575.8 265686.0 269061.0 270428.0 270587.0 271259.0 53936.7 53990.7 54370.7 54498.5 54580.7 49494.5 55608.7 58029.1 58241.0 62846.0 12871.7 13046.7 13064.6 13068.6 13088.2 9073.7 9944.1 10031.6 10093.5 10103.1 15743.4 16109.4 16228.2 16346.8 16622.0 5775.5 5784.4 5816.6 5910.4 5940.7 833.6 877.0 923.3 944.0 990.6 27405.7 28523.6 28878.1 28981.7 28984.6 914.5 970.7 1029.9 1062.6 1103.2 13978.2 14390.8 14767.1 14783.8 14925.5 369726.0 371483.0 373278.0 373572.0 374016.0 51328.2 51424.5 51702.2 51809.0 51858.7 1020.1 1181.0 1242.1 1245.2 1246.9 27701.3 28758.3 29093.3 29356.4 29592.7 41432.0 42100.4 42141.0 42162.0 42226.4 292639.0 296218.0 297047.0 297646.0 298154.0 22924.9 23776.5 24277.8 24614.8 24680.6 41689.6 41945.0 41979.2 42120.8 42518.4 35590.3 35637.6 35834.3 36057.8 36294.6 35232.8 35765.4 35804.3 36023.6 36246.3 34808.3 34856.3 35278.0 35569.0 35574.0 31401.8 32525.5 32576.3 32587.5 32711.5 24614.9 25218.2 25303.5 25311.4 25785.5 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#2] jquery.html Cycles:180 Average:24743.32 Median:413377.03 stddev:67477.23 (16.3%) stddev-sans-first:67641.71 13:51:54 INFO - PROCESS | 30071 | Values: 372.6 378.6 383.5 392.9 397.8 15829.4 16448.9 17295.2 17357.0 17388.8 14668.8 14834.8 15350.8 15439.4 15455.7 4995.4 5159.7 5184.3 5215.4 5221.4 3651.0 3907.8 5754.9 6072.1 6084.9 6037.6 6123.7 6127.5 6143.1 6155.1 5922.8 6043.7 6056.6 6119.6 6130.7 3357.2 4954.6 5240.9 5264.9 5310.7 19422.8 19770.3 20082.7 20094.3 20353.0 1869.3 1982.0 2168.8 2219.7 2339.7 12931.6 12970.0 13140.9 13228.8 13510.5 1734.3 1759.9 1799.9 1845.7 1852.2 64680.0 64735.4 65127.3 66320.0 67262.3 9398.2 9412.7 9749.9 9855.0 9908.6 13433.0 13501.2 13514.2 13535.3 13552.3 6658.6 6678.2 6741.4 6900.8 6936.3 6195.1 6305.2 6308.4 6329.7 6376.3 6036.4 6065.8 6100.9 6143.9 6298.8 1595.8 1664.2 1725.3 1798.7 1832.8 865.0 885.4 901.8 931.9 1001.0 16215.0 16857.6 16867.7 17184.2 17313.0 858.5 871.0 871.3 871.9 876.4 8896.3 9983.2 10139.7 10219.9 10276.3 400985.0 402789.0 412559.1 414195.0 416979.0 74733.6 78843.2 78896.6 80408.3 81086.0 934.6 938.2 942.3 943.3 952.3 15468.7 15485.5 15530.9 15610.5 15909.8 34779.3 36005.6 36383.5 36836.3 37466.3 48518.0 51046.5 51456.7 51474.0 51599.0 4557.5 4683.1 4736.3 6819.9 7543.8 11296.6 11296.8 11401.0 11771.9 11902.3 7007.5 9982.3 10106.7 10169.4 10252.5 10023.4 10154.4 10296.5 10326.9 10446.6 10114.1 10324.8 10375.4 10432.4 10480.3 6442.5 6818.8 6989.3 7130.0 7550.2 7625.1 9192.6 10288.9 10305.3 10324.1 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#3] mootools.html Cycles:180 Average:5156.40 Median:5336.88 stddev:2906.97 (54.5%) stddev-sans-first:2900.77 13:51:54 INFO - PROCESS | 30071 | Values: 1312.9 1442.3 1453.2 1605.7 1792.8 6538.2 7597.2 7753.3 7807.5 7961.8 7711.3 7873.1 7874.6 7879.3 7879.4 1870.5 2099.2 2158.9 2175.2 2181.1 2179.6 2194.5 2196.6 2200.4 2200.5 2158.2 2181.1 2206.3 2206.8 2207.2 1840.7 2082.5 2130.4 2159.8 2161.0 2172.4 2175.2 2194.4 2195.3 2199.5 7915.5 7976.6 7984.4 7991.8 8007.8 4305.2 4410.6 4428.1 4435.7 4440.5 2841.6 2858.2 2907.8 2946.7 2962.8 893.0 908.6 911.7 913.3 917.7 10668.7 10675.2 10683.3 10689.3 10715.3 4193.9 4236.1 4297.4 4310.0 4352.1 9202.0 9237.6 9245.7 9261.7 9269.3 4553.4 4559.2 4561.6 4563.6 4577.4 3476.7 3836.6 3945.1 3956.9 3983.6 3559.6 3621.1 3669.7 3691.8 3701.2 1172.4 1172.6 1180.3 1184.2 1189.7 724.9 742.3 760.9 854.6 900.8 5207.2 5322.6 5344.9 5375.5 5408.1 814.1 877.5 908.5 917.7 924.5 3498.0 3607.6 3706.1 3731.7 3733.7 9421.0 9776.5 9782.4 9784.5 9802.6 9575.5 9722.9 9730.9 9732.1 9732.2 7001.0 7125.9 7137.8 7365.2 7462.9 5112.1 5282.1 5328.5 5328.9 5392.2 8514.5 8854.3 8927.3 8941.4 9024.7 9070.8 9236.7 9261.0 9278.1 9313.7 6034.4 6422.6 6555.4 6639.3 6778.7 7660.3 7704.2 7744.8 7757.6 7772.1 6641.9 6811.8 6828.0 6908.0 6924.3 6613.4 6682.6 6782.2 6881.8 6882.4 6238.8 6259.3 6311.4 6335.1 6346.8 4707.9 4742.0 4788.1 4842.5 4847.1 4713.6 4755.5 4779.0 4824.6 4892.3 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#4] prototype.html Cycles:180 Average:4140.08 Median:4738.33 stddev:1179.35 (24.9%) stddev-sans-first:1146.40 13:51:54 INFO - PROCESS | 30071 | Values: 274.1 280.7 281.2 284.7 291.9 4700.5 4760.0 4782.5 4796.7 4798.3 4706.7 4728.9 4752.9 4773.3 4774.2 3555.8 3657.8 3680.7 3778.7 3788.8 3727.3 3747.6 3766.1 3779.0 3786.5 3563.6 3702.8 3710.3 3721.5 3735.0 3587.9 3738.4 3742.9 3751.1 3775.8 3313.3 3324.8 3331.2 3339.4 3356.5 4588.2 4588.6 4589.3 4592.8 4604.7 4199.3 4237.9 4303.6 4328.1 4333.9 4970.6 4989.5 5025.9 5027.1 5048.1 3638.6 3641.3 3659.8 3660.8 3666.1 4966.5 5179.8 5195.3 5251.7 5262.3 3690.9 3718.4 3719.8 3721.4 3726.8 3780.3 3784.2 3805.6 3808.0 3808.6 4256.4 4291.6 4298.3 4301.0 4314.8 4754.8 4940.7 4966.7 4984.0 5032.7 1289.9 1306.8 1315.0 1321.2 1323.2 851.3 856.3 886.2 902.4 915.8 4338.5 4387.6 4392.9 4396.0 4402.8 5037.2 5039.8 5057.3 5118.4 5140.2 4253.2 4305.3 4360.7 4369.9 4382.7 2703.9 2709.5 2713.7 2727.8 2734.2 4770.2 4796.0 4801.7 4822.8 4831.6 5084.8 5214.2 5216.9 5221.1 5263.4 4796.7 4804.0 4805.7 4811.1 4813.2 5009.4 5012.5 5045.0 5055.4 5062.3 4690.2 4973.8 5006.3 5026.8 5053.7 4722.8 4747.8 4793.4 4795.5 4803.0 3724.7 3729.8 3734.3 3734.9 3738.5 4862.4 5051.3 5061.8 5136.7 5139.2 4837.3 4867.2 4874.4 4888.0 4896.2 4911.1 4923.3 4931.2 4948.2 4949.8 4694.0 4846.5 4876.2 4901.3 4937.6 4857.7 4935.8 4986.0 4993.5 5013.8 4879.9 4894.5 4917.2 4969.8 4975.0 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - PROCESS | 30071 | [#5] yui.html Cycles:180 Average:12959.69 Median:46294.65 stddev:14948.27 (32.3%) stddev-sans-first:14961.48 13:51:54 INFO - PROCESS | 30071 | Values: 620.1 632.4 655.9 730.9 742.0 11215.7 11236.1 11248.4 11536.4 11909.1 13558.3 14107.2 14133.9 14143.6 14150.9 631.3 786.2 798.5 810.9 811.1 800.8 801.8 805.9 806.3 808.1 833.5 838.8 841.5 841.5 841.6 662.3 827.4 837.9 838.2 851.7 607.2 608.3 610.4 611.0 611.1 11780.1 11874.6 11878.5 11885.0 11893.2 12552.4 13080.5 13131.7 13157.6 13338.9 9577.2 9652.2 9710.0 9786.6 9801.7 3334.2 3347.7 3413.7 3465.5 3478.3 43081.6 43286.8 44794.8 45780.5 45845.5 9892.7 9893.6 9944.3 10264.9 10495.4 17591.5 17662.6 17671.5 17680.6 17690.8 6332.2 6568.0 6632.5 6634.5 6637.9 3557.1 3589.4 3615.2 3665.3 3676.1 2633.1 2726.3 2729.3 2732.0 2732.8 477.9 490.3 493.2 500.3 508.3 476.4 523.5 580.8 589.4 595.3 7577.1 7695.3 7701.5 7891.1 7898.2 469.7 509.9 515.7 557.3 601.9 3671.8 3846.6 3892.7 3927.9 3966.2 52776.7 53093.2 53947.7 53955.2 54023.7 49378.5 49879.5 50317.5 50772.0 51174.2 45133.5 45852.8 45896.0 46150.5 46438.8 7704.4 7754.7 7867.7 7908.2 7914.8 30340.4 30423.5 30582.2 31292.4 31719.2 36210.8 37110.0 37375.0 39434.8 40678.4 10398.3 10427.0 10447.4 10643.7 10687.8 11205.7 11279.6 11511.9 11518.6 11597.8 10558.5 10725.6 10816.0 10945.5 11265.7 10949.7 11234.3 11316.5 11392.9 11454.3 10654.5 10840.2 11019.0 11040.6 11352.1 9327.8 9354.3 9471.8 9507.7 9766.0 8571.6 8951.9 9135.0 9175.6 9211.8 13:51:54 INFO - PROCESS | 30071 | -------- Summary: end -------- 13:51:54 INFO - PROCESS | 30071 | 13:51:54 INFO - TEST-INFO | 30071: exit 0 13:51:54 INFO - TEST-OK | dromaeo_css | took 1118777ms 13:51:54 INFO - TEST-START | kraken 13:51:54 INFO - operating with platform_type : linux_ 13:51:54 INFO - Initialising browser for kraken test... 13:51:54 INFO - TEST-INFO | started process 30247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbrjv4h/profile http://localhost:58958/getInfo.html) 13:51:59 INFO - PROCESS | 30247 | __metrics Screen width/height:1600/1200 13:51:59 INFO - PROCESS | 30247 | colorDepth:24 13:51:59 INFO - PROCESS | 30247 | Browser inner width/height: 1024/697 13:51:59 INFO - PROCESS | 30247 | __metrics 13:52:00 ERROR - PROCESS | 30247 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:52:01 INFO - TEST-INFO | 30247: exit 0 13:52:01 INFO - Browser initialized. 13:52:01 INFO - Running cycle 1/1 for kraken test... 13:52:01 INFO - TEST-INFO | started process 30330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbrjv4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:13 INFO - PROCESS | 30330 | RSS: Main: 154877952 13:52:13 INFO - PROCESS | 30330 | 13:52:16 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58958/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:17 INFO - PROCESS | 30330 | RSS: Main: 210821120 13:52:17 INFO - PROCESS | 30330 | 13:52:20 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58958/tests/kraken/driver.html?testName=audio-dft) 13:52:20 INFO - PROCESS | 30330 | RSS: Main: 198443008 13:52:20 INFO - PROCESS | 30330 | 13:52:24 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58958/tests/kraken/driver.html?testName=audio-fft) 13:52:24 INFO - PROCESS | 30330 | RSS: Main: 267198464 13:52:24 INFO - PROCESS | 30330 | 13:52:27 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58958/tests/kraken/driver.html?testName=audio-oscillator) 13:52:27 INFO - PROCESS | 30330 | RSS: Main: 176283648 13:52:27 INFO - PROCESS | 30330 | 13:52:30 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:30 INFO - PROCESS | 30330 | RSS: Main: 180834304 13:52:30 INFO - PROCESS | 30330 | 13:52:33 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58958/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:34 INFO - PROCESS | 30330 | RSS: Main: 216641536 13:52:34 INFO - PROCESS | 30330 | 13:52:38 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58958/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:38 INFO - PROCESS | 30330 | RSS: Main: 215076864 13:52:38 INFO - PROCESS | 30330 | 13:52:41 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58958/tests/kraken/driver.html?testName=json-parse-financial) 13:52:42 INFO - PROCESS | 30330 | RSS: Main: 216096768 13:52:42 INFO - PROCESS | 30330 | 13:52:44 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:44 INFO - PROCESS | 30330 | RSS: Main: 208478208 13:52:44 INFO - PROCESS | 30330 | 13:52:46 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:47 INFO - PROCESS | 30330 | RSS: Main: 210849792 13:52:47 INFO - PROCESS | 30330 | 13:52:49 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:50 INFO - PROCESS | 30330 | RSS: Main: 217182208 13:52:50 INFO - PROCESS | 30330 | 13:52:53 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:53 INFO - PROCESS | 30330 | RSS: Main: 220266496 13:52:53 INFO - PROCESS | 30330 | 13:52:56 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:57 INFO - PROCESS | 30330 | RSS: Main: 219082752 13:52:57 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | Cycle 1(1): loaded http://localhost:58958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58958/tests/kraken/driver.html?testName=ai-astar) 13:52:59 INFO - PROCESS | 30330 | RSS: Main: 265224192 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | __start_tp_report 13:52:59 INFO - PROCESS | 30330 | _x_x_mozilla_page_load 13:52:59 INFO - PROCESS | 30330 | _x_x_mozilla_page_load_details 13:52:59 INFO - PROCESS | 30330 | |i|pagename|runs| 13:52:59 INFO - PROCESS | 30330 | |0;ai-astar;114;108;114;115;114;113;114;115;113;114 13:52:59 INFO - PROCESS | 30330 | |1;audio-beat-detection;157;140;159;219;131;157;162;133;197;131 13:52:59 INFO - PROCESS | 30330 | |2;audio-dft;161;162;162;161;162;161;161;162;162;161 13:52:59 INFO - PROCESS | 30330 | |3;audio-fft;77;75;75;164;76;74;76;75;135;77 13:52:59 INFO - PROCESS | 30330 | |4;audio-oscillator;93;95;156;95;94;94;123;94;93;127 13:52:59 INFO - PROCESS | 30330 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 13:52:59 INFO - PROCESS | 30330 | |6;imaging-darkroom;146;145;146;146;145;146;145;146;146;145 13:52:59 INFO - PROCESS | 30330 | |7;imaging-desaturate;94;95;95;94;94;95;94;94;94;94 13:52:59 INFO - PROCESS | 30330 | |8;json-parse-financial;64;64;63;63;64;63;63;64;63;64 13:52:59 INFO - PROCESS | 30330 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;68;65;66 13:52:59 INFO - PROCESS | 30330 | |10;stanford-crypto-aes;87;83;82;81;82;83;82;82;165;82 13:52:59 INFO - PROCESS | 30330 | |11;stanford-crypto-ccm;131;128;130;129;128;128;125;134;146;141 13:52:59 INFO - PROCESS | 30330 | |12;stanford-crypto-pbkdf2;173;173;174;174;171;176;172;174;169;171 13:52:59 INFO - PROCESS | 30330 | |13;stanford-crypto-sha256-iterative;66;66;65;65;66;66;66;65;64;65 13:52:59 INFO - PROCESS | 30330 | __end_tp_report 13:52:59 INFO - PROCESS | 30330 | __start_cc_report 13:52:59 INFO - PROCESS | 30330 | _x_x_mozilla_cycle_collect,2093 13:52:59 INFO - PROCESS | 30330 | __end_cc_report 13:52:59 INFO - PROCESS | 30330 | __startTimestamp1463691179601__endTimestamp 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | ------- Summary: start ------- 13:52:59 INFO - PROCESS | 30330 | Number of tests: 14 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 13:52:59 INFO - PROCESS | 30330 | Values: 114.0 108.0 114.0 115.0 114.0 113.0 114.0 115.0 113.0 114.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:158.00 stddev:29.18 (18.5%) stddev-sans-first:30.95 13:52:59 INFO - PROCESS | 30330 | Values: 157.0 140.0 159.0 219.0 131.0 157.0 162.0 133.0 197.0 131.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 13:52:59 INFO - PROCESS | 30330 | Values: 161.0 162.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 161.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#3] audio-fft Cycles:10 Average:90.40 Median:75.50 stddev:31.90 (42.3%) stddev-sans-first:33.47 13:52:59 INFO - PROCESS | 30330 | Values: 77.0 75.0 75.0 164.0 76.0 74.0 76.0 75.0 135.0 77.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:21.71 (23.1%) stddev-sans-first:22.47 13:52:59 INFO - PROCESS | 30330 | Values: 93.0 95.0 156.0 95.0 94.0 94.0 123.0 94.0 93.0 127.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:52:59 INFO - PROCESS | 30330 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:52:59 INFO - PROCESS | 30330 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:52:59 INFO - PROCESS | 30330 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:52:59 INFO - PROCESS | 30330 | Values: 64.0 64.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 64.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 13:52:59 INFO - PROCESS | 30330 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 68.0 65.0 66.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.00 stddev:26.09 (31.8%) stddev-sans-first:27.63 13:52:59 INFO - PROCESS | 30330 | Values: 87.0 83.0 82.0 81.0 82.0 83.0 82.0 82.0 165.0 82.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:130.50 stddev:6.60 (5.1%) stddev-sans-first:6.99 13:52:59 INFO - PROCESS | 30330 | Values: 131.0 128.0 130.0 129.0 128.0 128.0 125.0 134.0 146.0 141.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 13:52:59 INFO - PROCESS | 30330 | Values: 173.0 173.0 174.0 174.0 171.0 176.0 172.0 174.0 169.0 171.0 13:52:59 INFO - PROCESS | 30330 | 13:52:59 INFO - PROCESS | 30330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 13:52:59 INFO - PROCESS | 30330 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 64.0 65.0 13:52:59 INFO - PROCESS | 30330 | -------- Summary: end -------- 13:52:59 INFO - PROCESS | 30330 | 13:53:00 INFO - TEST-INFO | 30330: exit 0 13:53:00 INFO - TEST-OK | kraken | took 65886ms 13:53:00 INFO - SUITE-END | took 1184s 13:53:01 INFO - Completed test suite (00:19:45) 13:53:01 INFO - javascript benchmark 13:53:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.6033095035746, 2651.032373183786, 2683.0072873036966, 2688.045743760965, 2690.0046982616436, 4610.377599024131, 4637.327587499811, 4682.719036857791, 4705.2942058691215, 4784.760761961906, 4640.883977900554, 4657.231556793134, 4669.089527542131, 4676.438827340716, 4688.882777930554, 4092.0, 4210.6631469482445, 4343.348497725335, 4370.344448332759, 4443.066955939256, 4348.934765978513, 4383.430154079981, 4397.604215620593, 4404.4054052702795, 4425.513193548723, 4234.089670720809, 4275.935860962088, 4276.123394704078, 4291.0, 4321.308590625516, 4222.767747773872, 4228.534861165269, 4236.851710190129, 4271.508776490712, 4279.251131052053, 4271.722338048017, 4297.247981603207, 4303.763293018914, 4328.5238623751675, 4328.761918094504, 4450.599446049839, 4539.16025535277, 4571.702839315434, 4593.0, 4599.655025873039, 4946.332245146895, 5003.0, 5006.3241462402475, 5052.646314757969, 5060.114479965991, 4959.404871415417, 5011.098002359574, 5018.89962200754, 5024.899502009976, 5036.672616279967, 4503.031848152663, 4608.377868987711, 4701.600363969101, 4704.458987216514, 4771.33201351811, 5110.105731496973, 5142.485751424828, 5147.562457191106, 5159.097157997336, 5192.662476938987, 4774.4509381420885, 4888.584470320063, 4897.926531102036, 4938.827141050046, 4947.0, 4894.363732714724, 4965.478624744422, 4980.900381992412, 4982.950170498321, 5007.474215207423, 4944.406671199407, 4950.331705219749, 4962.528559786814, 4986.376702912136, 5020.849374518771, 4899.975500122477, 4900.509949005071, 4955.950440495621, 4973.278874563241, 5021.49785021495, 4265.296226122655, 4270.551592082787, 4288.120935208275, 4328.653707703376, 4329.242382583036, 3728.7762734236035, 3745.082454798537, 3748.6251374862295, 3759.5300587426573, 3773.1887644156636, 4250.3199488081755, 4300.311950087971, 4306.676999225071, 4312.611864932172, 4341.110072435144, 4926.187179115406, 4988.55103040728, 5036.6726162799305, 5037.5214354636255, 5057.039162559102, 4305.784710764449, 4306.935395969063, 4315.1585440838735, 4317.589828966243, 4363.934540981824, 4465.441819772528, 4489.304157855538, 4534.841280555164, 4559.954400456019, 4564.817407303737, 4676.859694209111, 4702.670813043054, 4711.952880471152, 4726.503717109723, 4729.456112546964, 4997.85006449807, 5010.398752149766, 5013.874653133555, 5016.147254966591, 5075.999999999853, 4596.0, 4680.742559159279, 4690.835820746258, 4705.082508910729, 4710.481846996896, 4913.0, 4921.729304888266, 4926.0, 4931.0, 4981.302617633607, 5005.374328208974, 5012.47369026247, 5018.673786203885, 5018.749062546931, 5026.220935754964, 4795.736234507136, 4827.903441931212, 4879.975600121977, 4893.266010098514, 4914.238293064581, 4878.731669758197, 4882.36529251195, 4891.095147397743, 4899.681520701143, 4935.4570997190995, 4688.859334219979, 4809.519048095302, 4826.6621336506105, 4885.0, 4887.022595480847, 4914.041761856547, 4955.5044495550155, 4957.206846904478, 4972.403311602631, 4973.602111831117, 4788.569028787426, 4816.277558366273, 4819.49395313487, 4820.638452116175, 4863.392075990501], "value": 4595.588600607075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.818086393218, 597.596622279961, 607.4381197392411, 607.6900780601892, 615.7198474694012, 40288.79855600721, 41802.163956720884, 41893.581064189384, 45810.312845307264, 45877.541224587745, 41303.0, 41830.163396732045, 41880.581194188046, 41896.58103418972, 41945.16109677804, 7587.506812057212, 7665.1951545087795, 7679.923200768005, 7706.190849960757, 7706.422018348619, 7766.339861111812, 7860.646270917822, 7869.449138560303, 7874.409419293547, 7891.092524359686, 7895.447318687694, 7929.1277959424415, 7936.285734283913, 7940.364770818321, 7948.9602551987155, 7825.647845846951, 7837.6864925402915, 7873.409494287951, 7895.644695988694, 7909.881351779757, 7837.725679601243, 7924.366050715929, 7924.524528528307, 7925.643346049442, 7929.563873986928, 38950.61049389498, 39442.60557394418, 39477.60522394768, 39539.40690889639, 39615.0, 2947.30738276507, 2984.880604775806, 3037.878484860625, 3067.2485241115846, 3142.3244002539336, 29622.555661665094, 29864.8506757467, 29900.700992990227, 31074.223144421343, 31076.844615777, 3416.2484253464445, 3525.1715846775987, 3531.5762108546883, 3553.3248682750195, 3575.76757510761, 265686.0, 269060.999999998, 270428.0, 270587.0, 271259.0, 53936.73031634895, 53990.730046350305, 54370.72814635901, 54498.455015450134, 54580.72709636506, 49494.50505494899, 55608.721956389956, 58029.12956305659, 58241.0, 62846.0, 12871.678208044874, 13046.673833154056, 13064.608061758163, 13068.607941761762, 13088.214707117604, 9073.682421115229, 9944.055314745088, 10031.598736050622, 10093.545790439448, 10103.090721834924, 15743.44897928567, 16109.436169734237, 16228.188590570424, 16346.75479867803, 16622.0, 5775.5090817281, 5784.421557844182, 5816.565979329988, 5910.438508341701, 5940.70296485174, 833.629035079396, 877.0396415924553, 923.3121324613072, 943.9905600943903, 990.6136606723384, 27405.72594274032, 28523.57214641782, 28878.133655990354, 28981.7101828979, 28984.565231521545, 914.5490086567929, 970.684527528556, 1029.9288739710616, 1062.6333914799382, 1103.167108832826, 13978.231197284043, 14390.83401651635, 14767.080279563588, 14783.778243326358, 14925.477608283658, 369726.0, 371483.0, 373278.0, 373572.0, 374016.0, 51328.23007654888, 51424.48575514197, 51702.22446663303, 51809.0, 51858.74070629698, 1020.1175982774995, 1180.9822852657217, 1242.0622430065243, 1245.1719606461602, 1246.9127161098818, 27701.30746731348, 28758.281042974093, 29093.272668183465, 29356.396096002292, 29592.704072959856, 41432.0, 42100.36849447199, 42141.0, 42162.0, 42226.36660450034, 292639.0, 296218.0, 297047.0, 297646.0, 298154.0, 22924.885375573016, 23776.52446951017, 24277.807037592847, 24614.753852461246, 24680.629790552797, 41689.58310416857, 41945.0, 41979.1604167921, 42120.78939605282, 42518.362224567274, 35590.28819423545, 35637.64362356447, 35834.28331433409, 36057.819710901276, 36294.637053630184, 35232.823835880656, 35765.40755467197, 35804.28391432209, 36023.63976360203, 36246.27507449783, 34808.30383392369, 34856.302873942885, 35278.0, 35569.0, 35574.0, 31401.8429907849, 32525.512117318733, 32576.34847302993, 32587.511187331736, 32711.509327360585, 24614.87692561526, 25218.24345269645, 25303.493930121662, 25311.36721581975, 25785.484290314464], "value": 17440.240394071647, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.56410000299655, 378.60814057450534, 383.47463974355156, 392.94105884117397, 397.8170041780781, 15829.366825326988, 16448.917755411236, 17295.221715022824, 17356.999999999967, 17388.826111738865, 14668.779968300483, 14834.777478337834, 15350.769738453931, 15439.382424702999, 15455.69088618227, 4995.375578052753, 5159.664621799571, 5184.274201611777, 5215.40022897366, 5221.425643179247, 3650.981745091284, 3907.785071821049, 5754.856128596798, 6072.119542666311, 6084.908726369108, 6037.637741735488, 6123.7244324005305, 6127.47916427102, 6143.1092491588915, 6155.076738489218, 5922.763089476416, 6043.6675982820925, 6056.606320589148, 6119.6328220306705, 6130.724117414705, 3357.211055402003, 4954.603631709455, 5240.9475905241225, 5264.947350526522, 5310.6813591184655, 19422.80577194224, 19770.308039218704, 20082.69875951862, 20094.296699615443, 20353.0, 1869.3457289948544, 1981.9702704459444, 2168.793964573363, 2219.700340454034, 2339.7075365579303, 12931.612051638465, 12970.0, 13140.86859131406, 13228.801567976392, 13510.527131550447, 1734.3062774890018, 1759.9120043997877, 1799.8650101242458, 1845.6954602490573, 1852.1572684428552, 64680.0, 64735.3526464734, 65127.348726513075, 66320.00519992253, 67262.3273767261, 9398.248140148771, 9412.67055653049, 9749.853752193723, 9854.950725246472, 9908.554115064839, 13433.0, 13501.189928604119, 13514.189148651112, 13535.32323383827, 13552.254625995665, 6658.567193132528, 6678.198616166092, 6741.426978706767, 6900.827479313058, 6936.271691472423, 6195.101710251988, 6305.243370795534, 6308.432241098231, 6329.715162817684, 6376.29860715321, 6036.426539478743, 6065.848353791191, 6100.938990610126, 6143.938560614426, 6298.779542715983, 1595.813735182807, 1664.1512828457574, 1725.30125299254, 1798.694221982266, 1832.8442082423144, 864.9870251946226, 885.4156256870434, 901.8376692195336, 931.8928323242914, 1000.9549570269355, 16215.0, 16857.57856053584, 16867.746983795252, 17184.226709798088, 17312.9612223267, 858.4806192253722, 870.9825803483894, 871.2724874729545, 871.930245580352, 876.4434584039053, 8896.332775041898, 9983.15143212835, 10139.695809125738, 10219.948900255451, 10276.332038417479, 400985.0, 402789.0, 412559.0580706459, 414195.0, 416979.0, 74733.626331868, 78843.21156788473, 78896.6055169732, 80408.3305838009, 81086.0, 934.6168071090956, 938.1790932933683, 942.3215284994793, 943.2642538819595, 952.2667545989688, 15468.690626187637, 15485.535433937, 15530.922345388653, 15610.45363412275, 15909.840901590836, 34779.30441391208, 36005.63994360128, 36383.45424818577, 36836.26327473382, 37466.25067498689, 48518.0, 51046.48953510566, 51456.74271628618, 51474.0, 51599.0, 4557.498675145665, 4683.110209060268, 4736.289556566542, 6819.897701534382, 7543.811404714926, 11296.6046188383, 11296.774064518828, 11401.0, 11771.88228117742, 11902.345371004332, 7007.509474336747, 9982.251331150048, 10106.747331316776, 10169.389836609827, 10252.538635761557, 10023.44871032071, 10154.39073655583, 10296.536655850654, 10326.896731032593, 10446.582136714447, 10114.140298074451, 10324.845127322946, 10375.429351385746, 10432.426216557858, 10480.318779279323, 6442.516811239082, 6818.795436136924, 6989.266127056586, 7130.0, 7550.244975502405, 7625.123110842324, 9192.586333615138, 10288.897111028793, 10305.282981464725, 10324.07083362501], "value": 8235.002646102897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.875276848699, 1442.2860683961442, 1453.208001639107, 1605.6949179655865, 1792.8476079533239, 6538.248101468333, 7597.202293759158, 7753.302202801747, 7807.453478256524, 7961.76114716558, 7711.344535714457, 7873.055233372003, 7874.645640946157, 7879.251471110249, 7879.369650427966, 1870.4575673054867, 2099.2023031248104, 2158.902849371774, 2175.1516908405733, 2181.1166477576608, 2179.574982878339, 2194.4623567226054, 2196.5716685246384, 2200.3618950504333, 2200.482886521666, 2158.179891641174, 2181.149351752818, 2206.2829580386438, 2206.8124209442217, 2207.1612787140944, 1840.74229607855, 2082.4897900014444, 2130.4141361125658, 2159.805617494417, 2160.967585486219, 2172.391730315514, 2175.2495389090736, 2194.3526659635445, 2195.2645863635703, 2199.516106456593, 7915.485493442908, 7976.561289129096, 7984.401169912222, 7991.760247192536, 8007.799805004864, 4305.203537345601, 4410.62509686677, 4428.092241090569, 4435.68950173488, 4440.533743956903, 2841.6305880235436, 2858.2425657200856, 2907.8400687962153, 2946.6905974872543, 2962.7777916656337, 893.0489029183898, 908.5956749246587, 911.6717981526646, 913.3287034029983, 917.6512925088424, 10668.733281667943, 10675.199360048027, 10683.30558513694, 10689.30519516229, 10715.30350527221, 4193.916121677549, 4236.110416812442, 4297.39836422901, 4309.978450107729, 4352.129574085196, 9202.0, 9237.630494780133, 9245.676401326056, 9261.72214833556, 9269.304802139866, 4553.408056952641, 4559.202139625552, 4561.566651168134, 4563.589276965089, 4577.404937358188, 3476.66971637694, 3836.5971572984995, 3945.11234972129, 3956.940645890314, 3983.64147226751, 3559.555055618048, 3621.0766254604905, 3669.6697297243377, 3691.796951167658, 3701.1672373715696, 1172.3762588814552, 1172.6130376975577, 1180.3272134883034, 1184.2006645514243, 1189.7025743564109, 724.9456290778213, 742.3319012888444, 760.8820632801925, 854.6367793687658, 900.8333458310234, 5207.21891716238, 5322.574194064466, 5344.866378340573, 5375.489328513785, 5408.053590621704, 814.0678922633551, 877.5436772878068, 908.4912449028565, 917.6833992272656, 924.4822899176482, 3497.965020349815, 3607.575007871876, 3706.054955986206, 3731.7201209909367, 3733.738638295293, 9421.0, 9776.484644880054, 9782.41305521671, 9784.461854598065, 9802.607895684092, 9575.521223938775, 9722.854157187649, 9730.902690973, 9732.07545283197, 9732.2214222862, 7001.0, 7125.89311160333, 7137.821554461076, 7365.189829118793, 7462.888056679154, 5112.130937740519, 5282.128448805904, 5328.49379308965, 5328.8934221314585, 5392.164214546751, 8514.48913065218, 8854.335924805537, 8927.285817134743, 8941.418807777474, 9024.684136055206, 9070.81858362816, 9236.676716314896, 9260.981292057733, 9278.11857873501, 9313.720588382359, 6034.39656034393, 6422.6467544285515, 6555.4427873629365, 6639.2696803352555, 6778.694958726967, 7660.310572048543, 7704.229577042251, 7744.7676569703, 7757.573333466714, 7772.106207785951, 6641.933580664325, 6811.829704257433, 6828.00993855898, 6907.965460172667, 6924.307569243036, 6613.404793568602, 6682.599044057372, 6782.220044694726, 6881.759138430131, 6882.449404047764, 6238.812835614939, 6259.311475737756, 6311.422144463884, 6335.1130841683125, 6346.841328966812, 4707.905841883212, 4741.952580474152, 4788.11419887322, 4842.491538388559, 4847.103285892122, 4713.622910167247, 4755.476897541199, 4778.952210477851, 4824.614030877591, 4892.31507588945], "value": 4141.658116728885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.05178083829946, 280.68219708468746, 281.2406502443403, 284.6740482147941, 291.87157650633725, 4700.482946875845, 4759.999999999995, 4782.545658162478, 4796.712197268166, 4798.280257961307, 4706.69406488578, 4728.872007596587, 4752.857414277569, 4773.284007398892, 4774.188387974044, 3555.8044307563073, 3657.76224545405, 3680.7485454945313, 3778.716596255278, 3788.7916164610933, 3727.2918145552394, 3747.550293964728, 3766.114962983697, 3778.981105094471, 3786.469894214812, 3563.5723713154457, 3702.796591107901, 3710.295043941656, 3721.5162028936334, 3734.9813250933844, 3587.8564857405804, 3738.3831667774784, 3742.9064273393246, 3751.0809851586537, 3775.8112094395447, 3313.3042061167184, 3324.817135057571, 3331.2171639664903, 3339.3655205510877, 3356.5329482830102, 4588.220002599533, 4588.646349326957, 4589.2657174851865, 4592.816287348502, 4604.6776725629215, 4199.265128602482, 4237.859880760197, 4303.63419109373, 4328.069465064995, 4333.873192969819, 4970.601018099009, 4989.476105008995, 5025.874353141164, 5027.120253955543, 5048.116579598593, 3638.5815631202486, 3641.3445579795625, 3659.8170091495317, 3660.8352624131976, 3666.120131168527, 4966.50334966504, 5179.81870634526, 5195.3246078009615, 5251.737413129328, 5262.342207224097, 3690.944635830465, 3718.401087532387, 3719.814009299524, 3721.3997980868485, 3726.8136593170234, 3780.3177585973976, 3784.1863999240295, 3805.562360328542, 3808.0, 3808.6000969898314, 4256.446661933991, 4291.570842915684, 4298.333758267474, 4301.032267739796, 4314.7626880521875, 4754.762261886961, 4940.728259945738, 4966.677165984272, 4983.975080124649, 5032.748362581856, 1289.8903593194495, 1306.8173303160654, 1314.9802752958713, 1321.1610627251764, 1323.245749922554, 851.2806678356778, 856.2978357746588, 886.1714297132202, 902.41794042842, 915.839728047589, 4338.501072376654, 4387.605115539617, 4392.934105988349, 4395.956040439619, 4402.801873915681, 5037.168867136955, 5039.79840806371, 5057.266696329012, 5118.38579370478, 5140.228965655107, 4253.170631726845, 4305.332673435622, 4360.672949528798, 4369.868903932887, 4382.693211475166, 2703.8783254753585, 2709.5368501009234, 2713.7150599186803, 2727.809053366285, 2734.1934129431866, 4770.212914869077, 4796.0, 4801.68789028712, 4822.807087716452, 4831.613470922318, 5084.7966081356335, 5214.165733482625, 5216.869578260574, 5221.086309895753, 5263.36839579253, 4796.664233503691, 4803.975980120077, 4805.663603547718, 4811.133995880705, 4813.181759100961, 5009.423916249532, 5012.548870601663, 5044.974775126101, 5055.443901170795, 5062.31658726082, 4690.249560070509, 4973.801047958041, 5006.299118123393, 5026.773795179152, 5053.67151135175, 4722.803896188151, 4747.786349614206, 4793.4247890252, 4795.544423279783, 4802.975985120052, 3724.6647801697977, 3729.757565758217, 3734.2718169956597, 3734.9439758404187, 3738.5139931809776, 4862.41651001882, 5051.318072060225, 5061.848144555669, 5136.666116702402, 5139.203423469218, 4837.322774811459, 4867.1969125095375, 4874.392200172891, 4887.951120488749, 4896.1921282987905, 4911.140550403737, 4923.258323674105, 4931.235658472942, 4948.158813001726, 4949.752512374439, 4694.0, 4846.5153484651255, 4876.171050921423, 4901.2893130496595, 4937.604991600591, 4857.732824694675, 4935.840077581694, 4986.002799440054, 4993.4756850530175, 5013.799448022184, 4879.902401952012, 4894.486078961658, 4917.188663870565, 4969.801207951786, 4974.9502504975935], "value": 3763.702680239795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.0791824141153, 632.3834261594942, 655.8524332025294, 730.8926975631919, 741.9777406677802, 11215.719607009829, 11236.101111911048, 11248.38133902636, 11536.423178841056, 11909.106816988739, 13558.30521184852, 14107.224102674374, 14133.929330353334, 14143.575692729235, 14150.858491415109, 631.3181763695221, 786.1509569664777, 798.5248776977718, 810.8864758933754, 811.0834756724893, 800.8478389106081, 801.8155824160447, 805.9113497515268, 806.3146325623233, 808.1474044882647, 833.4874052457756, 838.7944953486405, 841.4530555139178, 841.5119230846094, 841.6128580852815, 662.2913482573672, 827.3877330775243, 837.8533756592602, 838.1995194589183, 851.7019043334845, 607.2470137030051, 608.333874407523, 610.4231501231338, 611.0284647410595, 611.1474493082126, 11780.116491263103, 11874.584389546411, 11878.524859005629, 11885.049196064381, 11893.226940248856, 12552.372381380894, 13080.476780928846, 13131.671708207276, 13157.60527184186, 13338.866611333859, 9577.185939195177, 9652.22782177424, 9709.951450242774, 9786.580945762897, 9801.705948821547, 3334.1831251343574, 3347.715444187247, 3413.6586341365914, 3465.480177973299, 3478.252175782219, 43081.56918430807, 43286.78356608228, 44794.77602611999, 45780.542194578295, 45845.54154458446, 9892.653757118467, 9893.554790034466, 9944.30389872702, 10264.897351026544, 10495.370277783357, 17591.472255832345, 17662.646747064988, 17671.469855904343, 17680.55798605045, 17690.823091769176, 6332.176817013758, 6568.0, 6632.4694024478895, 6634.502412318999, 6637.933620663732, 3557.128503516655, 3589.4436362363876, 3615.204654975901, 3665.321915445651, 3676.062604036007, 2633.144228125867, 2726.291164297257, 2729.3176705823544, 2732.0437846753475, 2732.8496932668495, 477.9259214821708, 490.2885159343804, 493.20347638563464, 500.2721040885503, 508.3061620887536, 476.440182785226, 523.4922125538221, 580.8286555466148, 589.4311988930702, 595.2618752746649, 7577.128630207487, 7695.345895598824, 7701.537907725555, 7891.131975482693, 7898.210178982055, 469.7463369780349, 509.86998315429327, 515.6519349439113, 557.2783245696751, 601.9367966363557, 3671.7796932184156, 3846.5576458707606, 3892.6885849132, 3927.8625248116177, 3966.208618991213, 52776.736116319174, 53093.203601946, 53947.73026134844, 53955.19067213995, 54023.729881350344, 49378.50621493811, 49879.50120498821, 50317.49682503128, 50772.0, 51174.23238651423, 45133.54866451359, 45852.77073614678, 45896.0, 46150.53849461462, 46438.76780616075, 7704.383649308154, 7754.689812407666, 7867.724629637935, 7908.1581830860105, 7914.841703165789, 30340.393192136475, 30423.54364684576, 30582.235444114074, 31292.374152516368, 31719.207019823767, 36210.818945906154, 37110.0, 37375.0, 39434.80282598569, 40678.38982415207, 10398.27212095146, 10427.0, 10447.373157610567, 10643.680689579325, 10687.839682404614, 11205.719857003314, 11279.605213817476, 11511.94244028808, 11518.596849110241, 11597.768044638891, 10558.524866381185, 10725.570977160825, 10816.0, 10945.507452164513, 11265.71835704114, 10949.726256843642, 11234.269772464764, 11316.547338106384, 11392.886071139183, 11454.255473394203, 10654.520546575577, 10840.241183117107, 11019.0, 11040.558377665126, 11352.091832653534, 9327.76133727914, 9354.298427618092, 9471.763205919908, 9507.66723164686, 9765.951170244103, 8571.614277357408, 8951.865722014045, 9134.954325228331, 9175.632974680939, 9211.815763684823], "value": 5879.928609165545, "unit": "score"}], "name": "dromaeo_css", "value": 6265.583933229759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 140.0, 159.0, 219.0, 131.0, 157.0, 162.0, 133.0, 197.0, 131.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 164.0, 76.0, 74.0, 76.0, 75.0, 135.0, 77.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 156.0, 95.0, 94.0, 94.0, 123.0, 94.0, 93.0, 127.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 68.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 82.0, 81.0, 82.0, 83.0, 82.0, 82.0, 165.0, 82.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 130.0, 129.0, 128.0, 128.0, 125.0, 134.0, 146.0, 141.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 174.0, 174.0, 171.0, 176.0, 172.0, 174.0, 169.0, 171.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 64.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1576.8000000000002, "alertThreshold": 2.0}]} 13:53:01 INFO - Return code: 0 13:53:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:53:01 ERROR - # TBPL SUCCESS # 13:53:01 INFO - Running post-action listener: _resource_record_post_action 13:53:01 INFO - ##### 13:53:01 INFO - ##### Finished run-tests step (success) 13:53:01 INFO - ##### 13:53:01 INFO - Running post-run listener: _resource_record_post_run 13:53:01 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529088512; Read time: 8; Write time: 1051716 13:53:01 INFO - TinderboxPrint: CPU usage
13.1% 13:53:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:53:01 INFO - TinderboxPrint: I/O write bytes / time
529,088,512 / 1,051,716 13:53:01 INFO - TinderboxPrint: CPU idle
8,340.5 (86.9%) 13:53:01 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 13:53:01 INFO - TinderboxPrint: Swap in / out
0 / 0 13:53:01 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 236781568; Read time: 0; Write time: 649616 13:53:01 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292306944; Read time: 8; Write time: 402100 13:53:02 INFO - Running post-run listener: _upload_blobber_files 13:53:02 INFO - Blob upload gear active. 13:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:02 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 13:53:02 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'] 13:53:02 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 13:53:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:05 INFO - (blobuploader) - INFO - Done attempting. 13:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:06 INFO - (blobuploader) - INFO - Done attempting. 13:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:07 INFO - (blobuploader) - INFO - Done attempting. 13:53:07 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:07 INFO - Return code: 0 13:53:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb4b39e49cbcd536a845f19ba9c291e6c0b8576c082810054c5f0ed43c9c130dfed4671d7ce88c7c1952c0600fbfb214776b6321cbdef8625d78b00f5c25f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d1add156e84b34f2df5572b4cc2a8eb00b7ba4b6994d4059dc9a42ec70f3278f4dfa70307169f3c4f6ba0d5427f3b7aca6dad5555499ec8e8265419ef96b31a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4736beb802bf52458fbc1ca83e9db48b3a43c2704c297009a3cca9d287ca980484dab64b3c9adb7b096019d3266cc2ed703fbbce523a7b82dae95ad78960519b"} 13:53:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:07 INFO - Contents: 13:53:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb4b39e49cbcd536a845f19ba9c291e6c0b8576c082810054c5f0ed43c9c130dfed4671d7ce88c7c1952c0600fbfb214776b6321cbdef8625d78b00f5c25f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d1add156e84b34f2df5572b4cc2a8eb00b7ba4b6994d4059dc9a42ec70f3278f4dfa70307169f3c4f6ba0d5427f3b7aca6dad5555499ec8e8265419ef96b31a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4736beb802bf52458fbc1ca83e9db48b3a43c2704c297009a3cca9d287ca980484dab64b3c9adb7b096019d3266cc2ed703fbbce523a7b82dae95ad78960519b"} 13:53:07 INFO - Running post-run listener: copy_logs_to_upload_dir 13:53:07 INFO - Copying logs to upload dir... 13:53:07 INFO - mkdir: /builds/slave/test/build/upload/logs 13:53:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.859230 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-19 13:53:07.292622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 13:53:07.296130) ========= 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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 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/fb4b39e49cbcd536a845f19ba9c291e6c0b8576c082810054c5f0ed43c9c130dfed4671d7ce88c7c1952c0600fbfb214776b6321cbdef8625d78b00f5c25f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d1add156e84b34f2df5572b4cc2a8eb00b7ba4b6994d4059dc9a42ec70f3278f4dfa70307169f3c4f6ba0d5427f3b7aca6dad5555499ec8e8265419ef96b31a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4736beb802bf52458fbc1ca83e9db48b3a43c2704c297009a3cca9d287ca980484dab64b3c9adb7b096019d3266cc2ed703fbbce523a7b82dae95ad78960519b"} build_url:https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/FjlJea-TToSA14hkcT67-g/artifacts/public/build/firefox-49.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/fb4b39e49cbcd536a845f19ba9c291e6c0b8576c082810054c5f0ed43c9c130dfed4671d7ce88c7c1952c0600fbfb214776b6321cbdef8625d78b00f5c25f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d1add156e84b34f2df5572b4cc2a8eb00b7ba4b6994d4059dc9a42ec70f3278f4dfa70307169f3c4f6ba0d5427f3b7aca6dad5555499ec8e8265419ef96b31a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4736beb802bf52458fbc1ca83e9db48b3a43c2704c297009a3cca9d287ca980484dab64b3c9adb7b096019d3266cc2ed703fbbce523a7b82dae95ad78960519b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 13:53:07.322382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:53:07.322726) ========= 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=af724c981e2a0f424dbabf99000001e7-1463689937.324664-1128055245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:53:07.407179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 13:53:07.407489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 13:53:07.407796) ========= ========= Total master_lag: 0.17 =========