builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1463734836.39 results: success (0) buildid: 20160519233025 builduid: df97911c063843d686b3492b79762233 revision: 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.385564) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.386235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.386563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.403160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.403477) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 02:00:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211K=0.06s 2016-05-20 02:00:36 (211 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.558196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.558546) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021398 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.608788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:36.609160) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a --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 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a --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=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 02:00:37,047 truncating revision to first 12 chars 2016-05-20 02:00:37,047 Setting DEBUG logging. 2016-05-20 02:00:37,047 attempt 1/10 2016-05-20 02:00:37,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00ed91d9c2c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 02:00:37,278 unpacking tar archive at: fx-team-00ed91d9c2c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:37.136211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:37.136549) ========= script_repo_revision: 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:37.136968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:37.137265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 02:00:37.145185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-20 02:00:37.145483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:00:37 INFO - MultiFileLogger online at 20160520 02:00:37 in /builds/slave/test 02:00:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:00:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:00:37 INFO - {'append_to_log': False, 02:00:37 INFO - 'base_work_dir': '/builds/slave/test', 02:00:37 INFO - 'blob_upload_branch': 'Fx-Team', 02:00:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:00:37 INFO - 'branch': 'Fx-Team', 02:00:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:00:37 INFO - 'config_files': ('talos/linux_config.py',), 02:00:37 INFO - 'default_actions': ('clobber', 02:00:37 INFO - 'read-buildbot-config', 02:00:37 INFO - 'download-and-extract', 02:00:37 INFO - 'populate-webroot', 02:00:37 INFO - 'create-virtualenv', 02:00:37 INFO - 'install', 02:00:37 INFO - 'run-tests'), 02:00:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:00:37 INFO - 'download_minidump_stackwalk': True, 02:00:37 INFO - 'download_symbols': 'ondemand', 02:00:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:00:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:00:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:00:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:00:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:00:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:00:37 INFO - 'installer_path': 'installer.exe', 02:00:37 INFO - 'log_level': 'info', 02:00:37 INFO - 'log_name': 'talos', 02:00:37 INFO - 'log_to_console': True, 02:00:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:00:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:00:37 INFO - 'opt_config_files': (), 02:00:37 INFO - 'pip_index': False, 02:00:37 INFO - 'sps_profile': False, 02:00:37 INFO - 'sps_profile_interval': 0, 02:00:37 INFO - 'suite': 'dromaeojs', 02:00:37 INFO - 'system_bits': '32', 02:00:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:37 INFO - 'title': 'talos-linux64-ix-019', 02:00:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:00:37 INFO - 'use_talos_json': True, 02:00:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:00:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:00:37 INFO - 'work_dir': 'build'} 02:00:37 INFO - ##### 02:00:37 INFO - ##### Running clobber step. 02:00:37 INFO - ##### 02:00:37 INFO - Running pre-action listener: _resource_record_pre_action 02:00:37 INFO - Running main action method: clobber 02:00:37 INFO - rmtree: /builds/slave/test/build 02:00:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:00:38 INFO - Running post-action listener: _resource_record_post_action 02:00:38 INFO - ##### 02:00:38 INFO - ##### Finished clobber step (success) 02:00:38 INFO - ##### 02:00:38 INFO - ##### 02:00:38 INFO - ##### Running read-buildbot-config step. 02:00:38 INFO - ##### 02:00:38 INFO - Running pre-action listener: _resource_record_pre_action 02:00:38 INFO - Running main action method: read_buildbot_config 02:00:38 INFO - Using buildbot properties: 02:00:38 INFO - { 02:00:38 INFO - "project": "", 02:00:38 INFO - "product": "firefox", 02:00:38 INFO - "script_repo_revision": "production", 02:00:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:00:38 INFO - "repository": "", 02:00:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:00:38 INFO - "buildid": "20160519233025", 02:00:38 INFO - "pgo_build": "True", 02:00:38 INFO - "basedir": "/builds/slave/test", 02:00:38 INFO - "buildnumber": 703, 02:00:38 INFO - "slavename": "talos-linux64-ix-019", 02:00:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:00:38 INFO - "platform": "ubuntu64_hw", 02:00:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:00:38 INFO - "branch": "fx-team", 02:00:38 INFO - "repo_path": "integration/fx-team", 02:00:38 INFO - "revision": "00ed91d9c2c83fec8c61565ef1f73ed7a7df724a", 02:00:38 INFO - "stage_platform": "linux64-pgo", 02:00:38 INFO - "builduid": "df97911c063843d686b3492b79762233", 02:00:38 INFO - "slavebuilddir": "test" 02:00:38 INFO - } 02:00:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:00:38 INFO - Running post-action listener: _resource_record_post_action 02:00:38 INFO - ##### 02:00:38 INFO - ##### Finished read-buildbot-config step (success) 02:00:38 INFO - ##### 02:00:38 INFO - ##### 02:00:38 INFO - ##### Running download-and-extract step. 02:00:38 INFO - ##### 02:00:38 INFO - Running pre-action listener: _resource_record_pre_action 02:00:38 INFO - Running main action method: download_and_extract 02:00:38 INFO - mkdir: /builds/slave/test/build/tests 02:00:38 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')]} 02:00:38 INFO - https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:42 INFO - Downloaded 1361 bytes. 02:00:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:00:42 INFO - Using the following test package requirements: 02:00:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:00:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:00:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'jsshell-linux-x86_64.zip'], 02:00:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:00:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:00:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:00:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:00:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:00:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:42 INFO - https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:47 INFO - Downloaded 24387199 bytes. 02:00:47 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'] 02:00:47 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 02:00:48 INFO - Return code: 0 02:00:48 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 02:00: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')]} 02:00:48 INFO - https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:50 INFO - Downloaded 24387199 bytes. 02:00:50 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'] 02:00:50 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 02:00:52 INFO - Return code: 0 02:00: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')]} 02:00:52 INFO - https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:53 INFO - Downloaded 10840359 bytes. 02:00:53 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'] 02:00:53 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 02:00:53 INFO - Return code: 0 02:00:53 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')]} 02:00:53 INFO - https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XtwNK2xGROyY20UCLnhRBg/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 02:00:54 INFO - Downloaded 58576791 bytes. 02:00:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:00:54 INFO - mkdir: /builds/slave/test/properties 02:00:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:54 INFO - Contents: 02:00:54 INFO - build_url:https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:00:55 INFO - Running post-action listener: _resource_record_post_action 02:00:55 INFO - Running post-action listener: set_extra_try_arguments 02:00:55 INFO - ##### 02:00:55 INFO - ##### Finished download-and-extract step (success) 02:00:55 INFO - ##### 02:00:55 INFO - ##### 02:00:55 INFO - ##### Running populate-webroot step. 02:00:55 INFO - ##### 02:00:55 INFO - Running pre-action listener: _resource_record_pre_action 02:00:55 INFO - Running main action method: populate_webroot 02:00:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:55 INFO - '--tppagecycles', 02:00:55 INFO - '7'], 02:00:55 INFO - 'tests': ['tsvgm']}}, 02:00:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['damp', 'tps']}, 02:00:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'tests': ['damp', 'tps']}, 02:00:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['dromaeo_dom']}, 02:00:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['a11yr', 02:00:55 INFO - 'ts_paint', 02:00:55 INFO - 'tpaint', 02:00:55 INFO - 'sessionrestore', 02:00:55 INFO - 'sessionrestore_no_auto_restore', 02:00:55 INFO - 'tabpaint']}, 02:00:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['tsvgx', 02:00:55 INFO - 'tsvgr_opacity', 02:00:55 INFO - 'tart', 02:00:55 INFO - 'tscrollx', 02:00:55 INFO - 'cart']}, 02:00:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:55 INFO - 'tsvgr_opacity', 02:00:55 INFO - 'tart', 02:00:55 INFO - 'tscrollx', 02:00:55 INFO - 'cart']}, 02:00:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'talos_options': ['--disable-e10s'], 02:00:55 INFO - 'tests': ['tp5o']}, 02:00:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'tests': ['tp5o']}, 02:00:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'talos_options': ['--disable-e10s', 02:00:55 INFO - '--xperf_path', 02:00:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:55 INFO - 'tests': ['tp5n']}, 02:00:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:55 INFO - 'talos_options': ['--xperf_path', 02:00:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:55 INFO - 'tests': ['tp5n']}}, 02:00:55 INFO - 'talos.zip': {'path': '', 02:00:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:55 INFO - Running post-action listener: _resource_record_post_action 02:00:55 INFO - ##### 02:00:55 INFO - ##### Finished populate-webroot step (success) 02:00:55 INFO - ##### 02:00:55 INFO - ##### 02:00:55 INFO - ##### Running create-virtualenv step. 02:00:55 INFO - ##### 02:00:55 INFO - Running pre-action listener: _resource_record_pre_action 02:00:55 INFO - Running main action method: create_virtualenv 02:00:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:55 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 02:00:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:55 INFO - Using real prefix '/usr' 02:00:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:58 INFO - Installing pip.................done. 02:00:58 INFO - Return code: 0 02:00:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:00:58 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 02:00:58 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 02:00:58 INFO - Using env: {'DISPLAY': ':0', 02:00:58 INFO - 'HOME': '/home/cltbld', 02:00:58 INFO - 'LANG': 'en_US.UTF-8', 02:00:58 INFO - 'LANGUAGE': 'en_US:en', 02:00:58 INFO - 'LOGNAME': 'cltbld', 02:00:58 INFO - 'MAIL': '/var/mail/cltbld', 02:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:58 INFO - 'MOZ_NO_REMOTE': '1', 02:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:58 INFO - 'NO_EM_RESTART': '1', 02:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:58 INFO - 'PWD': '/builds/slave/test', 02:00:58 INFO - 'SHELL': '/bin/bash', 02:00:58 INFO - 'SHLVL': '1', 02:00:58 INFO - 'TERM': 'linux', 02:00:58 INFO - 'TMOUT': '86400', 02:00:58 INFO - 'USER': 'cltbld', 02:00:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:58 INFO - '_': '/tools/buildbot/bin/python'} 02:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:58 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 02:00:58 INFO - Cleaning up... 02:00:58 INFO - Return code: 0 02:00:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:58 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:00:58 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 02:00:58 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 02:00:58 INFO - Using env: {'DISPLAY': ':0', 02:00:58 INFO - 'HOME': '/home/cltbld', 02:00:58 INFO - 'LANG': 'en_US.UTF-8', 02:00:58 INFO - 'LANGUAGE': 'en_US:en', 02:00:58 INFO - 'LOGNAME': 'cltbld', 02:00:58 INFO - 'MAIL': '/var/mail/cltbld', 02:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:58 INFO - 'MOZ_NO_REMOTE': '1', 02:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:58 INFO - 'NO_EM_RESTART': '1', 02:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:58 INFO - 'PWD': '/builds/slave/test', 02:00:58 INFO - 'SHELL': '/bin/bash', 02:00:58 INFO - 'SHLVL': '1', 02:00:58 INFO - 'TERM': 'linux', 02:00:58 INFO - 'TMOUT': '86400', 02:00:58 INFO - 'USER': 'cltbld', 02:00:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:58 INFO - '_': '/tools/buildbot/bin/python'} 02:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:58 INFO - Downloading/unpacking psutil>=3.1.1 02:00:58 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 02:00:58 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 02:00:58 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 02:00:58 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 02:00:58 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 02:00:58 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 02:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:00 INFO - Installing collected packages: psutil 02:01:00 INFO - Running setup.py install for psutil 02:01:00 INFO - building 'psutil._psutil_linux' extension 02:01:00 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 02:01:00 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 02:01:00 INFO - building 'psutil._psutil_posix' extension 02:01:00 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 02:01:00 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 02:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:00 INFO - Successfully installed psutil 02:01:00 INFO - Cleaning up... 02:01:01 INFO - Return code: 0 02:01:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:01 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')]} 02:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:01 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')]} 02:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:01 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:01 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 02:01:01 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 02:01:01 INFO - Using env: {'DISPLAY': ':0', 02:01:01 INFO - 'HOME': '/home/cltbld', 02:01:01 INFO - 'LANG': 'en_US.UTF-8', 02:01:01 INFO - 'LANGUAGE': 'en_US:en', 02:01:01 INFO - 'LOGNAME': 'cltbld', 02:01:01 INFO - 'MAIL': '/var/mail/cltbld', 02:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:01 INFO - 'MOZ_NO_REMOTE': '1', 02:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:01 INFO - 'NO_EM_RESTART': '1', 02:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:01 INFO - 'PWD': '/builds/slave/test', 02:01:01 INFO - 'SHELL': '/bin/bash', 02:01:01 INFO - 'SHLVL': '1', 02:01:01 INFO - 'TERM': 'linux', 02:01:01 INFO - 'TMOUT': '86400', 02:01:01 INFO - 'USER': 'cltbld', 02:01:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:01 INFO - '_': '/tools/buildbot/bin/python'} 02:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:03 INFO - Installing collected packages: mozsystemmonitor 02:01:03 INFO - Running setup.py install for mozsystemmonitor 02:01:03 INFO - Successfully installed mozsystemmonitor 02:01:03 INFO - Cleaning up... 02:01:03 INFO - Return code: 0 02:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:03 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:03 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 02:01:03 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 02:01:03 INFO - Using env: {'DISPLAY': ':0', 02:01:03 INFO - 'HOME': '/home/cltbld', 02:01:03 INFO - 'LANG': 'en_US.UTF-8', 02:01:03 INFO - 'LANGUAGE': 'en_US:en', 02:01:03 INFO - 'LOGNAME': 'cltbld', 02:01:03 INFO - 'MAIL': '/var/mail/cltbld', 02:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:03 INFO - 'MOZ_NO_REMOTE': '1', 02:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:03 INFO - 'NO_EM_RESTART': '1', 02:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:03 INFO - 'PWD': '/builds/slave/test', 02:01:03 INFO - 'SHELL': '/bin/bash', 02:01:03 INFO - 'SHLVL': '1', 02:01:03 INFO - 'TERM': 'linux', 02:01:03 INFO - 'TMOUT': '86400', 02:01:03 INFO - 'USER': 'cltbld', 02:01:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:03 INFO - '_': '/tools/buildbot/bin/python'} 02:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:01:03 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 02:01:03 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 02:01:03 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 02:01:03 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 02:01:03 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 02:01:03 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 02:01:05 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:05 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 02:01:06 INFO - Downloading docopt-0.6.1.tar.gz 02:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:06 INFO - Running setup.py install for blobuploader 02:01:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:06 INFO - Running setup.py install for requests 02:01:06 INFO - Running setup.py install for docopt 02:01:06 INFO - Successfully installed blobuploader requests docopt 02:01:06 INFO - Cleaning up... 02:01:06 INFO - Return code: 0 02:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:06 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:06 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 02:01:06 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 02:01:06 INFO - Using env: {'DISPLAY': ':0', 02:01:06 INFO - 'HOME': '/home/cltbld', 02:01:06 INFO - 'LANG': 'en_US.UTF-8', 02:01:06 INFO - 'LANGUAGE': 'en_US:en', 02:01:06 INFO - 'LOGNAME': 'cltbld', 02:01:06 INFO - 'MAIL': '/var/mail/cltbld', 02:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:06 INFO - 'MOZ_NO_REMOTE': '1', 02:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:06 INFO - 'NO_EM_RESTART': '1', 02:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:06 INFO - 'PWD': '/builds/slave/test', 02:01:06 INFO - 'SHELL': '/bin/bash', 02:01:06 INFO - 'SHLVL': '1', 02:01:06 INFO - 'TERM': 'linux', 02:01:06 INFO - 'TMOUT': '86400', 02:01:06 INFO - 'USER': 'cltbld', 02:01:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:06 INFO - '_': '/tools/buildbot/bin/python'} 02:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:07 INFO - Running setup.py (path:/tmp/pip-kIxeF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:07 INFO - Running setup.py (path:/tmp/pip-TNxSES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:07 INFO - Running setup.py (path:/tmp/pip-fxwL_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:07 INFO - Running setup.py (path:/tmp/pip-P9o4UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:07 INFO - Running setup.py (path:/tmp/pip-Wd7aXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:07 INFO - Running setup.py (path:/tmp/pip-tbUvWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:07 INFO - Running setup.py (path:/tmp/pip-QexEhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:07 INFO - Running setup.py (path:/tmp/pip-DTU6Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:07 INFO - Running setup.py (path:/tmp/pip-Um01rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:07 INFO - Running setup.py (path:/tmp/pip-ZkDwy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:07 INFO - Running setup.py (path:/tmp/pip-cvmpDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:07 INFO - Running setup.py (path:/tmp/pip-Jp45Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:07 INFO - Running setup.py (path:/tmp/pip-g_Upt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:07 INFO - Running setup.py (path:/tmp/pip-hOsLyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:07 INFO - Running setup.py (path:/tmp/pip-nlSTUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:08 INFO - Running setup.py (path:/tmp/pip-ThQG7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:08 INFO - Running setup.py (path:/tmp/pip-w4PspF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:08 INFO - Running setup.py install for manifestparser 02:01:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:08 INFO - Running setup.py install for mozcrash 02:01:08 INFO - Running setup.py install for mozdebug 02:01:08 INFO - Running setup.py install for mozdevice 02:01:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:08 INFO - Running setup.py install for mozfile 02:01:08 INFO - Running setup.py install for mozhttpd 02:01:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:08 INFO - Running setup.py install for mozinfo 02:01:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:08 INFO - Running setup.py install for mozInstall 02:01:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Running setup.py install for mozleak 02:01:09 INFO - Running setup.py install for mozlog 02:01:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Running setup.py install for moznetwork 02:01:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Running setup.py install for mozprocess 02:01:09 INFO - Running setup.py install for mozprofile 02:01:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Running setup.py install for mozrunner 02:01:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:09 INFO - Running setup.py install for mozscreenshot 02:01:09 INFO - Running setup.py install for moztest 02:01:09 INFO - Running setup.py install for mozversion 02:01:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:10 INFO - Cleaning up... 02:01:10 INFO - Return code: 0 02:01:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:10 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 02:01:10 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 02:01:10 INFO - Using env: {'DISPLAY': ':0', 02:01:10 INFO - 'HOME': '/home/cltbld', 02:01:10 INFO - 'LANG': 'en_US.UTF-8', 02:01:10 INFO - 'LANGUAGE': 'en_US:en', 02:01:10 INFO - 'LOGNAME': 'cltbld', 02:01:10 INFO - 'MAIL': '/var/mail/cltbld', 02:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:10 INFO - 'MOZ_NO_REMOTE': '1', 02:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:10 INFO - 'NO_EM_RESTART': '1', 02:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:10 INFO - 'PWD': '/builds/slave/test', 02:01:10 INFO - 'SHELL': '/bin/bash', 02:01:10 INFO - 'SHLVL': '1', 02:01:10 INFO - 'TERM': 'linux', 02:01:10 INFO - 'TMOUT': '86400', 02:01:10 INFO - 'USER': 'cltbld', 02:01:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:10 INFO - '_': '/tools/buildbot/bin/python'} 02:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:10 INFO - Running setup.py (path:/tmp/pip-bihyHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:10 INFO - Running setup.py (path:/tmp/pip-ROLFzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:10 INFO - Running setup.py (path:/tmp/pip-Xcd3F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:10 INFO - Running setup.py (path:/tmp/pip-pRHaHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:10 INFO - Running setup.py (path:/tmp/pip-NdoW2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:10 INFO - Running setup.py (path:/tmp/pip-3vI7_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:10 INFO - Running setup.py (path:/tmp/pip-A3G48j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:10 INFO - Running setup.py (path:/tmp/pip-aaMkJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:10 INFO - Running setup.py (path:/tmp/pip-wNsOOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:10 INFO - Running setup.py (path:/tmp/pip-zFoYVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:10 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)) 02:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:10 INFO - Running setup.py (path:/tmp/pip-XAV4tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:11 INFO - Running setup.py (path:/tmp/pip-kp9gvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:11 INFO - Running setup.py (path:/tmp/pip-7SRkHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:11 INFO - Running setup.py (path:/tmp/pip-fsDNFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:11 INFO - Running setup.py (path:/tmp/pip-lpD64a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:11 INFO - Running setup.py (path:/tmp/pip-E5gra3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:11 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)) 02:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:11 INFO - Running setup.py (path:/tmp/pip-u5AUP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:11 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)) 02:01:11 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)) 02:01:11 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)) 02:01:11 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)) 02:01:11 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)) 02:01:11 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)) 02:01:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:13 INFO - Downloading blessings-1.6.tar.gz 02:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:01:13 INFO - Installing collected packages: blessings 02:01:13 INFO - Running setup.py install for blessings 02:01:13 INFO - Successfully installed blessings 02:01:13 INFO - Cleaning up... 02:01:13 INFO - Return code: 0 02:01:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:13 INFO - Reading from file tmpfile_stdout 02:01:13 INFO - Current package versions: 02:01:13 INFO - argparse == 1.2.1 02:01:13 INFO - blessings == 1.6 02:01:13 INFO - blobuploader == 1.2.4 02:01:13 INFO - docopt == 0.6.1 02:01:13 INFO - manifestparser == 1.1 02:01:13 INFO - mozInstall == 1.12 02:01:13 INFO - mozcrash == 0.17 02:01:13 INFO - mozdebug == 0.1 02:01:13 INFO - mozdevice == 0.48 02:01:13 INFO - mozfile == 1.2 02:01:13 INFO - mozhttpd == 0.7 02:01:13 INFO - mozinfo == 0.9 02:01:13 INFO - mozleak == 0.1 02:01:13 INFO - mozlog == 3.2 02:01:13 INFO - moznetwork == 0.27 02:01:13 INFO - mozprocess == 0.22 02:01:13 INFO - mozprofile == 0.28 02:01:13 INFO - mozrunner == 6.11 02:01:13 INFO - mozscreenshot == 0.1 02:01:13 INFO - mozsystemmonitor == 0.3 02:01:13 INFO - moztest == 0.7 02:01:13 INFO - mozversion == 1.4 02:01:13 INFO - psutil == 3.1.1 02:01:13 INFO - requests == 1.2.3 02:01:13 INFO - wsgiref == 0.1.2 02:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:13 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')]} 02:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:13 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')]} 02:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:13 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:13 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 02:01:13 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 02:01:13 INFO - Using env: {'DISPLAY': ':0', 02:01:13 INFO - 'HOME': '/home/cltbld', 02:01:13 INFO - 'LANG': 'en_US.UTF-8', 02:01:13 INFO - 'LANGUAGE': 'en_US:en', 02:01:13 INFO - 'LOGNAME': 'cltbld', 02:01:13 INFO - 'MAIL': '/var/mail/cltbld', 02:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:13 INFO - 'MOZ_NO_REMOTE': '1', 02:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:13 INFO - 'NO_EM_RESTART': '1', 02:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:13 INFO - 'PWD': '/builds/slave/test', 02:01:13 INFO - 'SHELL': '/bin/bash', 02:01:13 INFO - 'SHLVL': '1', 02:01:13 INFO - 'TERM': 'linux', 02:01:13 INFO - 'TMOUT': '86400', 02:01:13 INFO - 'USER': 'cltbld', 02:01:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:13 INFO - '_': '/tools/buildbot/bin/python'} 02:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 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)) 02:01:14 INFO - Cleaning up... 02:01:14 INFO - Return code: 0 02:01:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:01: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')]} 02:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01: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')]} 02:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:14 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 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:14 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 02:01:14 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 02:01:14 INFO - Using env: {'DISPLAY': ':0', 02:01:14 INFO - 'HOME': '/home/cltbld', 02:01:14 INFO - 'LANG': 'en_US.UTF-8', 02:01:14 INFO - 'LANGUAGE': 'en_US:en', 02:01:14 INFO - 'LOGNAME': 'cltbld', 02:01:14 INFO - 'MAIL': '/var/mail/cltbld', 02:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:14 INFO - 'MOZ_NO_REMOTE': '1', 02:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:14 INFO - 'NO_EM_RESTART': '1', 02:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:14 INFO - 'PWD': '/builds/slave/test', 02:01:14 INFO - 'SHELL': '/bin/bash', 02:01:14 INFO - 'SHLVL': '1', 02:01:14 INFO - 'TERM': 'linux', 02:01:14 INFO - 'TMOUT': '86400', 02:01:14 INFO - 'USER': 'cltbld', 02:01:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:14 INFO - '_': '/tools/buildbot/bin/python'} 02:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:14 INFO - Downloading/unpacking jsonschema 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:16 INFO - Downloading/unpacking functools32 (from jsonschema) 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:16 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:16 INFO - warning: no files found matching '*.txt' 02:01:16 INFO - no previously-included directories found matching 'build' 02:01:16 INFO - no previously-included directories found matching 'dist' 02:01:16 INFO - no previously-included directories found matching '.git*' 02:01:16 INFO - Installing collected packages: jsonschema, functools32 02:01:16 INFO - Running setup.py install for functools32 02:01:16 INFO - warning: no files found matching '*.txt' 02:01:16 INFO - no previously-included directories found matching 'build' 02:01:16 INFO - no previously-included directories found matching 'dist' 02:01:16 INFO - no previously-included directories found matching '.git*' 02:01:16 INFO - Successfully installed jsonschema functools32 02:01:16 INFO - Cleaning up... 02:01:16 INFO - Return code: 0 02:01:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f106fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', '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 02:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:01:16 INFO - Using env: {'DISPLAY': ':0', 02:01:16 INFO - 'HOME': '/home/cltbld', 02:01:16 INFO - 'LANG': 'en_US.UTF-8', 02:01:16 INFO - 'LANGUAGE': 'en_US:en', 02:01:16 INFO - 'LOGNAME': 'cltbld', 02:01:16 INFO - 'MAIL': '/var/mail/cltbld', 02:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:16 INFO - 'MOZ_NO_REMOTE': '1', 02:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:16 INFO - 'NO_EM_RESTART': '1', 02:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:16 INFO - 'PWD': '/builds/slave/test', 02:01:16 INFO - 'SHELL': '/bin/bash', 02:01:16 INFO - 'SHLVL': '1', 02:01:16 INFO - 'TERM': 'linux', 02:01:16 INFO - 'TMOUT': '86400', 02:01:16 INFO - 'USER': 'cltbld', 02:01:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:16 INFO - '_': '/tools/buildbot/bin/python'} 02:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:16 INFO - Downloading/unpacking flake8 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:01:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:01:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:19 INFO - no previously-included directories found matching 'docs/_build' 02:01:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:01:19 INFO - Running setup.py install for pep8 02:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:19 INFO - no previously-included directories found matching 'docs/_build' 02:01:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:01:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:01:19 INFO - Cleaning up... 02:01:19 INFO - Return code: 0 02:01:19 INFO - Running post-action listener: _resource_record_post_action 02:01:19 INFO - Running post-action listener: _start_resource_monitoring 02:01:19 INFO - Starting resource monitoring. 02:01:19 INFO - ##### 02:01:19 INFO - ##### Finished create-virtualenv step (success) 02:01:19 INFO - ##### 02:01:19 INFO - ##### 02:01:19 INFO - ##### Running install step. 02:01:19 INFO - ##### 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: install 02:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:19 INFO - Reading from file tmpfile_stdout 02:01:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:01:20 INFO - Reading from file tmpfile_stdout 02:01:20 INFO - Output received: 02:01:20 INFO - Usage: mozinstall [options] installer 02:01:20 INFO - Options: 02:01:20 INFO - -h, --help show this help message and exit 02:01:20 INFO - -d DEST, --destination=DEST 02:01:20 INFO - Directory to install application into. [default: 02:01:20 INFO - "/builds/slave/test"] 02:01:20 INFO - --app=APP Application being installed. [default: firefox] 02:01:20 INFO - mkdir: /builds/slave/test/build/application 02:01:20 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'] 02:01:20 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 02:01:36 INFO - Reading from file tmpfile_stdout 02:01:36 INFO - Output received: 02:01:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:01:36 INFO - Running post-action listener: _resource_record_post_action 02:01:36 INFO - ##### 02:01:36 INFO - ##### Finished install step (success) 02:01:36 INFO - ##### 02:01:36 INFO - ##### 02:01:36 INFO - ##### Running run-tests step. 02:01:36 INFO - ##### 02:01:36 INFO - Running pre-action listener: _resource_record_pre_action 02:01:36 INFO - Running main action method: run_tests 02:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:36 INFO - Python 2.7.3 02:01:36 INFO - Return code: 0 02:01:36 INFO - grabbing minidump binary from tooltool 02:01: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')]} 02:01:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a69c0>, '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 0x19a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:01:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:01:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:01:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:36 INFO - Return code: 0 02:01:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:01:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:01:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:01:37 INFO - Return code: 0 02:01:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 02:01:37 INFO - Using env: {'DISPLAY': ':0', 02:01:37 INFO - 'HOME': '/home/cltbld', 02:01:37 INFO - 'LANG': 'en_US.UTF-8', 02:01:37 INFO - 'LANGUAGE': 'en_US:en', 02:01:37 INFO - 'LOGNAME': 'cltbld', 02:01:37 INFO - 'MAIL': '/var/mail/cltbld', 02:01:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:37 INFO - 'MOZ_NO_REMOTE': '1', 02:01:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:37 INFO - 'NO_EM_RESTART': '1', 02:01:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:37 INFO - 'PWD': '/builds/slave/test', 02:01:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:37 INFO - 'SHELL': '/bin/bash', 02:01:37 INFO - 'SHLVL': '1', 02:01:37 INFO - 'TERM': 'linux', 02:01:37 INFO - 'TMOUT': '86400', 02:01:37 INFO - 'USER': 'cltbld', 02:01:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782', 02:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:37 INFO - '_': '/tools/buildbot/bin/python'} 02:01:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:01:37 INFO - mozversion application_buildid: 20160519233025 02:01:37 INFO - mozversion application_changeset: 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a 02:01:37 INFO - mozversion application_display_name: Nightly 02:01:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:37 INFO - mozversion application_name: Firefox 02:01:37 INFO - mozversion application_remotingname: firefox 02:01:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:01:37 INFO - mozversion application_vendor: Mozilla 02:01:37 INFO - mozversion application_version: 49.0a1 02:01:37 INFO - mozversion platform_buildid: 20160519233025 02:01:37 INFO - mozversion platform_changeset: 00ed91d9c2c83fec8c61565ef1f73ed7a7df724a 02:01:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:01:37 INFO - mozversion platform_version: 49.0a1 02:01:37 INFO - using testdate: 1463734897 02:01:37 INFO - actual date: 1463734897 02:01:37 INFO - starting webserver on 'localhost:40820' 02:01:37 INFO - SUITE-START | Running 2 tests 02:01:37 INFO - TEST-START | dromaeo_css 02:01:37 INFO - operating with platform_type : linux_ 02:01:37 INFO - Initialising browser for dromaeo_css test... 02:01:37 INFO - TEST-INFO | started process 12573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvuCii/profile http://localhost:40820/getInfo.html) 02:01:41 INFO - PROCESS | 12573 | __metrics Screen width/height:1600/1200 02:01:41 INFO - PROCESS | 12573 | colorDepth:24 02:01:41 INFO - PROCESS | 12573 | Browser inner width/height: 1024/697 02:01:41 INFO - PROCESS | 12573 | __metrics 02:01:43 ERROR - PROCESS | 12573 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:01:43 INFO - TEST-INFO | 12573: exit 0 02:01:43 INFO - Browser initialized. 02:01:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:43 INFO - TEST-INFO | started process 12658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvuCii/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:55 INFO - PROCESS | 12658 | RSS: Main: 152936448 02:01:55 INFO - PROCESS | 12658 | 02:02:46 INFO - PROCESS | 12658 | 1463734966639 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] 02:04:54 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40820/tests/dromaeo/cssquery-ext.html) 02:04:55 INFO - PROCESS | 12658 | RSS: Main: 253796352 02:04:55 INFO - PROCESS | 12658 | 02:07:57 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-ext.html (next: http://localhost:40820/tests/dromaeo/cssquery-jquery.html) 02:07:58 INFO - PROCESS | 12658 | RSS: Main: 234958848 02:07:58 INFO - PROCESS | 12658 | 02:11:00 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40820/tests/dromaeo/cssquery-mootools.html) 02:11:00 INFO - PROCESS | 12658 | RSS: Main: 245796864 02:11:00 INFO - PROCESS | 12658 | 02:14:02 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40820/tests/dromaeo/cssquery-prototype.html) 02:14:03 INFO - PROCESS | 12658 | RSS: Main: 233857024 02:14:03 INFO - PROCESS | 12658 | 02:17:05 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40820/tests/dromaeo/cssquery-yui.html) 02:17:06 INFO - PROCESS | 12658 | RSS: Main: 220209152 02:17:06 INFO - PROCESS | 12658 | 02:20:08 INFO - PROCESS | 12658 | Cycle 1(1): loaded http://localhost:40820/tests/dromaeo/cssquery-yui.html (next: http://localhost:40820/tests/dromaeo/cssquery-dojo.html) 02:20:09 INFO - PROCESS | 12658 | RSS: Main: 260820992 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | __start_tp_report 02:20:09 INFO - PROCESS | 12658 | _x_x_mozilla_page_load 02:20:09 INFO - PROCESS | 12658 | _x_x_mozilla_page_load_details 02:20:09 INFO - PROCESS | 12658 | |i|pagename|runs| 02:20:09 INFO - PROCESS | 12658 | |0;dojo.html;3073.43141518819;3083.845807709615;3104.8913288034923;3106.6582675905647;3145.4180976519347;5140.331756871611;5167.9741601292035;5221;5330.600204984622;5337.14605663094;5259.053370393337;5288.312519372476;5306.628536002481;5334.706591137486;5382.085045542258;4733.739644319561;4820.734859582722;4833.661643684944;4846.7818948147415;4981.153203955337;4772.761361931907;4779.402574678165;4811.831585894494;4824;4852.078105160026;4667.743274119922;4706.10583989041;4743.762811859393;4750.76246187691;4813.446453657839;4736.905261894777;4749.572538471554;4778.784954677048;4824.107540105092;4855.757212139414;4645.581897629229;4762.214234651278;4778.4982576829625;4788.928166077511;4832.710037397767;5135.0500157470615;5201.921971170435;5204.4535323791215;5288.048151332759;5296.152615581488;5633.15502674598;5644.74598643062;5646.26598542191;5667.8583035424035;5671.517920976722;5461.863453413696;5561.749721262553;5644.153376993443;5685.147227915804;5694.1458781183155;5249.317588713481;5345.705986170759;5369.516743493065;5373.596980226538;5385.246065550826;5862.003459411911;5874.500667443315;5879.206307148565;5894.557908156906;5896.997510423238;5329.173978033411;5498.697571633598;5556.833295001156;5649.12438572022;5652.0391533439415;5690.800821971294;5708.0581704019205;5744.655320680772;5757.568182386338;5761.769529218868;5692.857678558069;5693.857653558612;5701.486866182064;5707.229524014288;5708.628939118944;5478.671279723229;5559.054960656698;5605.663660180402;5624.325080990226;5690.857728556736;4323.027318853296;4339.7396156230725;4339.9783001085425;4343.305071188658;4377.781110944504;3864.2271545690974;3884.3008258513173;3907.3943538751537;3911.3350730375337;3912.8043597819997;5206.739663016834;5268;5286.867828304246;5337.466253374631;5343.171808369631;5723.856903577361;5732.656040637575;5738.885222295531;5741.942580574224;5750.712464376765;5334.1732031535175;5380.865478362994;5385.299911011622;5385.380681221632;5431.131019037014;4588.564086411786;4689.296605509133;4704.717716936994;4733.100710864925;4765.571098601143;5970.194023806817;5973.641581505123;5979.850503737442;5982.551308651781;5985.281766188085;5539.556835453234;5772.3938986406665;5778.942210578009;5784.681842498703;5788.594798364243;5809.796657116981;5837.328707198726;5838.4453476919625;5910.734016969161;5920.200772895604;5609.467100625434;5627.690477023639;5630.127330263816;5631.211630371669;5634;5529.391766905717;5629.88740225185;5718.51392631631;5733;5733.0540460823495;5528.44715528444;5570.053090974625;5575.080111781511;5581.246531718166;5621;5559.11054231321;5565.3599836019375;5565.6104072714525;5568.693721845338;5571.3871474137;5283.9432113578205;5395.2176934343515;5431.701256430934;5444.373897001896;5554.166874968787;5636.943630563642;5646.774129034792;5648.774049037993;5649.180868774087;5666.744996475086;5492.47821456961;5494.670319780826;5495.972520137374;5497.422770609029;5497.8075767347955 02:20:09 INFO - PROCESS | 12658 | |1;ext.html;606.3512042114936;629.4209327418774;638.4062821575935;639.9392057754518;657.7763560389467;33957.830210848944;43957.56042439575;44598.55401445985;44751.55248447515;44802.32796508055;45620.54379456204;46234.225946443155;46303.30545041827;46315;46378.072438551295;7882.2117788221;8709.346798990086;8893.244074253664;8911.509866957314;10411.06300432961;10053.145482633949;10519.158467322633;10521.316114452575;10522.631707890225;10523.315984461024;10582.470876456186;10639.840402393971;10641.73395665107;10646;10654.360738355685;10546.47267636619;10567.26029177958;10587.788244235073;10600.628977985734;10608.575656973711;10395.376277423378;10456.163506919429;10470.947645261725;10474.633387831389;10486.056254937015;41089.38365924513;41416.79291603553;41625.79187104045;41643.37534936978;41651;3255.430299697567;3377.4764911438765;3397.0741329242223;3437.862485500577;3492.1618811485314;33050.504242436386;33088.52570480113;33387.6661233387;33388;34436.82781586101;4331.653467722606;4340.305551111807;4341.869743907688;4374.4094547236355;4380.036391993756;338274;338422;339275;339420;340751;59321;59341.40658593445;59568.70215648981;59658.70170649119;59912.70043649841;31458.213544661565;31986.84006579999;32042.359152816814;33488.83255583706;33596.49605255923;15871.841281587267;15924.840751592568;15953.521394358188;15956.202189890459;15985.760213596805;11279.379634120201;11743.11926605508;11821.468033938494;11845.289282642896;12784.872151278369;19741.506462338555;19937.60124797525;20063.598728025358;20079.59840803205;20203.696944545845;6063.421188011057;7175.7709030936285;7214.458915581247;7237.819054523679;7329.230430804795;984.2863923655435;991.4596544883057;1036.2538971940191;1101.730076131337;1123.6966019174777;32673.34653306968;32933.67066329306;33326.50010249848;33327.176609775524;33651.495227571606;1100.3287994323457;1101.8787933327328;1180.1208099965409;1200.1239095460362;1210.727586293077;17068;17174.914125429543;17232.913835430994;17380.3047878086;17610.559736006704;522697;524625;526984;529153;529616;59206.40793592095;59836.70081649564;59908.40091599115;59935.700321498116;59954.700226498586;1330.7072444062292;1361.1084739495645;1367.1865240182076;1376.2843321472778;1379.5723325768843;30951;31070.689293106778;32214.355712885143;32501.18747031343;32868.178295542806;52861.471385287194;53468;53497.46502535081;53514.46485535095;53564.46435535595;442021;449755;450058;451342;451615;25287.620685690097;27956.30109247285;28330.858345708963;28699;29736;47658.523414766794;48367;48447.5155248443;49127.26309105438;50015.749921250164;38475.807620961714;41190.58809411868;41434.36177548938;41990.79004604957;42143.789281053396;41333.58666413297;41488;41842.79078604587;42375.788121059195;42564.1487170261;37310.813445932596;40789.98025049397;41440.3783943235;41678.79160604178;41707.16585668331;35554.82222588974;36718.8164059178;36918.94026098656;37198.070048249014;37483.625163748016;28116.71883281141;28331.291717707223;28336.433271334045;28390.4511936008;28508.144755657362 02:20:09 INFO - PROCESS | 12658 | |2;jquery.html;366.0409726516524;379.11854937270834;390.93158697227994;390.97849618271;404.9939250911235;17080.743788843163;18657.34699285525;19929.501762455944;19997.500062498446;20209.898950505263;18813.905930470362;18981.247719080726;19436.805631943713;19546.12042458089;19726.70409943852;5649.6327738696855;5731.684757338345;5792.652440853562;5855.76576936922;5899.557533185007;5699.03116470199;5725.685087320196;5787.594868359217;5792.536597072245;5828.03837366834;5782.219400380936;5812.622179558336;5819.068948968166;5833.066709326508;5851.7074146292725;5614.719264036802;5783.942160578404;5790.913136302916;5794.304683437972;5817.360090390075;4969.0807200668;5195.064888320101;5242.108841496916;5277.366715994067;5353.063213937584;13321.733565328735;13342.266175360352;13345.799813002814;19044;21928.671069933964;2157.4822042709793;2202.64757638777;2267.251806903718;2278.054607337953;2337.777911098443;9827.459489728062;9863;9911;10314.349704047392;10363.274570780048;1757.2443849144863;1817.3820900893627;1866.318793640325;1877.098992483602;1973.1219607274768;77527.61236193783;77968.22031779723;78422;78652.60673696594;79613.60193198996;8834.734957951272;9304.441733496013;9386.249100071978;9866.556004979793;10106.898931010743;13080.149790263793;13113.213207207598;13148.211107333591;13230.536931207555;13241.536546221028;7480.925190748023;7631.809204769926;7731.110922244014;7809.843803123906;7830.2169783021245;7636.3890888728765;7687.154413014564;7737.729179478803;7814.921850781419;7827;4100.282450571138;4112.3420252759415;4116.5060192777055;4127.33962565994;4151.045259590251;1937.4962509747568;2001.229526632228;2009.3770931011434;2017.5157962089286;2026.5136367271748;937.7936853892132;995.382862625177;1043.9060484556426;1075.8171110911164;1096.7203363142507;18943.905280473784;19565.51086222856;19774.505637358892;19781.208751649774;19872.90063549702;962.6005207838668;1009.9545520451597;1016.0855230292796;1022.6880801355658;1052.6999805055675;10636.946815265874;10900.50947707355;11006.119510439306;11007.834882476769;11056.668299951014;450227;450607;450702;454078;456707;95580.52209738907;96979.51510242544;97202;98863;98905.50547247361;995.8107959487675;1015.6952914125881;1017.5726194998118;1021.8722659667542;1026.9075783179549;16976.660466790843;17364.7639457108;17659.205335759663;17673.911630441766;17758.822411776233;40600.39099413452;41005.79497102495;41871.85961052872;42659.78670106754;42827.57172428236;58255.70872145782;58655;60310.39689603048;60312.69843650753;60433.69783151056;8870.866936996079;12099.879001209874;12906.35468226566;13076.346182690637;13351.132176408502;13053.412596433373;13726.245056521988;13863.4454621814;14490.130592164503;14696.191709455656;11591;12434.626961190817;12493.43779529905;12774.23354598727;12839.165454245443;12628.242305461701;12904.741905162033;13104.2137471752;13141.737165256833;13188;13138.934305328412;13243.801342980056;13307.401166947317;13358.332083395597;13360.331983400985;13130;13141.671458213239;13154.21074735519;13243.337833108499;13384.263865487492;12910;13089.672758181121;13129;13130.474781008652;13240.602781916557 02:20:09 INFO - PROCESS | 12658 | |3;mootools.html;1362.611655678132;1434.3545404567947;1500.422337400101;1611.5084899105768;1802.143981608736;8073.51558906466;8390.79023024424;8420.200080992303;8621.224089831914;8621.267192288664;8333.874991875111;8523;8536.95731521343;8539;8550.973883134033;2007.6486614842418;2259.367377134405;2302.712160979882;2328.5342931413784;2333.88330583471;2392.9162479313227;2393.964090538643;2394.724606670238;2401.387646150229;2405.891734871935;2318.6869772580653;2320.721513418384;2346;2350.059976009601;2352.494213744045;1963.1460314763053;2208.9668654970187;2227.354067320475;2266.0482597309006;2269.931902042941;2275.8634481931135;2279.680844681746;2298.195631528968;2306.3542208181734;2307.734610519795;8541.658333666646;8586.87119693205;8599.914000859973;8602.2688071514;8613.784655383603;5083.822066227701;5184.300119483897;5201.713905735183;5208.635395522277;5216.739163041832;3127.390158919012;3203.0711093782775;3233.8868139615;3406.812625305607;3444.2078321986082;990.9594925328377;992.846108853129;999.3154689037959;1008.5915204342253;1050.0759331787979;11293.60472383471;11535.307881527135;11641.883581164164;11987.580434684744;11995.940020299842;4449.377087207794;4471.8658440246845;4528.728276303433;4532.002959348938;4540.79566419512;9337.299702522203;9386.20217281525;9386.483743394043;9398.389104708172;9417.76455588602;5225.790968361299;5229.137192363293;5230.529252367305;5231.293775340357;5237.214417837355;4179.226843034048;4744.7627618618935;4828.95171048292;4834.6374021947795;4949.950500495021;3822.57951625321;3881.262560113626;3928.3910993796007;4016.979915100406;4057.046594050396;1160.9419529023514;1163.1276542593055;1170.7834050700649;1182.5269892043252;1202.0683969923205;702.6592102830124;784.4273680213477;825.2778818533783;856.1566856646199;924.117467818232;5502.614816962774;5566.888662226733;5581.944180558143;5777.624454410534;5787;931.4783721116197;983.4836710726926;988.0761488008735;989.9158571521357;1002.1281485107856;3712.5916149223563;3717.683996860243;3800.239952009609;3819.1788765415567;3893.5717071122153;10347.94826025865;10592.15262778976;10617.256792024484;10660.360378377321;10678.572857085785;9946.254030947563;10524.36853788775;10632.521536530874;10771.515281812337;10784.676459706221;8005.439619226599;8321.791955201168;8392.32861371101;8405.95797021011;8410.243078122876;5250.579953603627;5341.572674185978;5717.970765262293;5977.432143946318;6051.304100028553;9695.466749328854;9924.801503970024;9969.40183588987;9977.850332245167;10016.449095299537;9416.717498475056;9647.228221742103;9696.321257511907;9778.511074446107;10050.296479246383;6602.316409315594;7040.260772619006;7185.964070179615;7484;7664.34853037498;7915.208479152038;8121.4721043132;8145.104038555873;8167.264946154874;8182.509049457051;6936.132983377078;7112.35988761014;7148.821279468055;7155.391791697764;7294.489385742947;7066.4700147490175;7081.433485321265;7106.111736032996;7213.783586492414;7215.098112735908;6215.06773983906;6405.615663060045;6408.166938297992;6506.056621789909;6524.67376631176;4936.703797772145;4949.678270912379;4979.879527106372;4993.026359859792;4996.15065438869;4690.742009189527;4742.762861856824;4968.8757781055765;5067.645264831426;5154.1237989542615 02:20:09 INFO - PROCESS | 12658 | |4;prototype.html;307.3453543951385;308.1372157957718;313.6032918358276;316.8985924504159;320.322517874695;5292.364916210051;5307;5335.253064570953;5362.28406909789;5364.91952620711;5209.374875015003;5233;5241.161414173733;5264.289320941672;5311.49540793625;3893.688504919614;3961.8114565630194;4072.839240816368;4079.7556745192705;4105.275784170655;4116.855910043149;4119.258533463975;4119.8352065917325;4130.421740956269;4138.461999940004;3940.8177546736006;4093.5497095319492;4096.927304521609;4100.876973690794;4130.607592278729;3973.9205215895663;4112.198121366335;4112.540048282876;4125.793710314502;4139.089400331953;3636.381815091441;3643.2713457308646;3660.158163622382;3662.7436079474446;3672.2288319452946;5055;5063.316452278968;5076.340075790161;5113.335266415379;5124.975004999015;4512.255477846152;4676.5089665584965;4682.765861706901;4709.670323077386;4757.238841785298;5349.5720342372515;5386.461353864583;5398.46015398457;5403.621746477748;5418.91871621926;3960.5049368828895;3983.24318379507;3986.5614782373914;3993.24128415603;4016.6585840203616;5384.488473595042;5693.943060569382;5718.485336319751;5721.885562288772;5727.9952016794205;3914.041059940333;3929.7445666031617;3937.330653788863;3938.932060668115;3941.8620348287673;3975.840966361371;4011.859584914514;4023.5775243599587;4034.5561988181275;4039.1517781265675;4493.73037617744;4532;4562.24722920721;4673.462551806586;4680.7191568506;5472.261244731911;5524.281843360337;5539.9169012464845;5545.805896793593;5549.139883318092;1422.5418945580861;1439.5609339151658;1439.7048605035943;1453.738327101132;1461.6199788055183;922.7819278552247;930.8277968575835;939.5349302095507;950.2303134461108;965.8985806490358;5131.7690703918415;5285.762140703678;5290.788368465295;5300.628955973045;5328.706921119298;5586.720663966786;5628.943710562924;5631.577631677641;5633.746481408347;5673.574481913791;5178.97410512945;5305.283786688825;5309.301023672465;5312.31727977369;5318.813841515528;2970.702929707012;2971.3314504236373;2985.8656360463833;2993.8054026488207;3024.6370435547874;5556.944430555724;5810.4189581041555;5838.737256823453;5898.351181370046;5901.970490147522;5717.514011309086;5832.795852145155;5863.651360187181;5868.706564671749;5888.823335299948;5838.941610583925;5843.3864444233595;5888.793892213837;5923.141144533933;5939.3763654816485;5378;5643.7742490299925;5678.574106941914;5697.601167918206;5741;5594.02104631696;5596.272484576979;5597.888042239214;5607.467290607386;5633.38032816398;5751.396103409249;5954.1244507979845;5976.641401515923;5996.160537524663;6007.939920600738;3901.785401802928;3939.8030098495533;3943.152222272225;3944.9605503944595;3968.305546529288;5699.686517241592;5735.971320143372;5742.339630942328;5763.5965482417505;5798.913016304843;5290.1800220965815;5604.047311957059;5614.915776263441;5627.621232797991;5631.239782629456;5534.52956498686;5552.722363881709;5570.777168913198;5574.498295153294;5603.971980140236;5292.655977361459;5309.920351194813;5520.91718624229;5522.889542209053;5533.3083364579425;5526.088195447867;5578.9163162553405;5588.413216612197;5605.673645437098;5612.607117501736;5399.4600539945695;5424.267723857387;5447.319085114361;5459.645123066988;5486.31421072366 02:20:09 INFO - PROCESS | 12658 | |5;yui.html;721.2967356827094;728.876091064519;791.5923299500754;799.1089934722783;810.4407958508626;13535.52625658102;13667.906567474603;13738.107023043494;13905.30473476326;14023.649408764773;13848.376823042961;13886.305684715775;14019.299035048258;14020.64948376291;14023.92988035061;680.0343512212645;787.7597332813503;796.0407708711018;828.9751307460785;832.3923535818856;803.2329125684986;811.9553424561647;812.4434762187891;813.7518056992644;814.2915663372873;839.3956351426963;841.1252297610478;841.5834162089774;841.7895526118471;842.5534466732641;707.4057791455176;817.1215942861447;821.1829229916212;843.0852525010371;843.7215718812777;605.8091701114136;605.9697015149225;606.5966132521868;608.333874407523;609.3662590905453;13537.323133843367;13540.526081587195;13545.322733863268;13548;13583;13113.344332783417;13361.53234636783;13406.865931340757;13460.192388456626;13760.793588096187;11823.940880295544;11833.881661183364;11924.284542927453;11941.10441716866;11976.640700778991;4394.670399720034;4445.977770111161;4467.597916187558;4506.369108324837;4624.306354046887;58577;59212;59241.703791481195;60399;61121;11160.553577856957;11241.83137252942;11272.605458808903;11310.886891131147;11402.885971140182;20498.692519612217;20560.691589626167;20569.48576285605;20574;20593.897030514752;7661.770146895602;7663.425243106789;7827.569483678452;7977.122516523178;8251.2986396157;4417.094495628388;4420;4479.790456576706;4496.797644106023;4583.72497650142;3299.2741596848655;3412.5563676721868;3414;3414.897553073412;3415.3169366126376;552.9668219906819;555.5305766627193;606.5693357715983;635.4979566142788;650.817771024114;519.187471606934;573.1088157914483;656.967151642416;659.8416380068749;734.8309888725623;8697.478151310816;9037.502937338379;9054;9139.90860091404;9159.90840091604;628.8710814283153;653.4837478392112;686.5571706249541;688.0985908459834;708.5465302206592;4354.629856462173;4382.53983331752;4401.317795741666;4450.621697155713;4485.439320084989;69749;70702.64648676723;70893;71346;72286.63856680683;45719.31421028687;46742;48624.5137548627;62291.688541557;62472.687636562434;56615.150772738445;57327.71336143293;57683;57902.42097579055;58798;8580.910396750607;8677.1756683115;8716.869246961427;8733.606987685696;8756.168164024408;39421.408678870415;39705.602943971346;39742.80128599339;39754.80122599369;40129.197416050934;44275.33586996262;45166.09667806691;46092.53907461017;49111.50888491069;53311;10702.678919632424;11017.669469915916;11037.668869933916;11058.170637202082;11081.445927703744;11450.599229026944;11494.54021839117;11551.249168804;11561.710957226136;11938.403079846146;10900.291481053706;10918.454077296263;10978.121750259801;11072.335659860435;11249.831252531383;10677.51951162184;10775.946120269662;10864.022237998619;10937.945310273397;11064.059554937921;9968.750781230527;10292.897071029194;10341.84487232677;10575.418351990715;10612.204084693833;9318.440893546409;9423.148492742836;9513.66702165421;9610.471424071744;9670.081342272473;9260.30547708911;9393.201577865684;9408.341416100808;9443.952780236055;9468.384555003902 02:20:09 INFO - PROCESS | 12658 | __end_tp_report 02:20:09 INFO - PROCESS | 12658 | __start_cc_report 02:20:09 INFO - PROCESS | 12658 | _x_x_mozilla_cycle_collect,860 02:20:09 INFO - PROCESS | 12658 | __end_cc_report 02:20:09 INFO - PROCESS | 12658 | __startTimestamp1463736009119__endTimestamp 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | ------- Summary: start ------- 02:20:09 INFO - PROCESS | 12658 | Number of tests: 6 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#0] dojo.html Cycles:165 Average:5266.51 Median:5492.48 stddev:610.81 (11.1%) stddev-sans-first:587.95 02:20:09 INFO - PROCESS | 12658 | Values: 3073.4 3083.8 3104.9 3106.7 3145.4 5140.3 5168.0 5221.0 5330.6 5337.1 5259.1 5288.3 5306.6 5334.7 5382.1 4733.7 4820.7 4833.7 4846.8 4981.2 4772.8 4779.4 4811.8 4824.0 4852.1 4667.7 4706.1 4743.8 4750.8 4813.4 4736.9 4749.6 4778.8 4824.1 4855.8 4645.6 4762.2 4778.5 4788.9 4832.7 5135.1 5201.9 5204.5 5288.0 5296.2 5633.2 5644.7 5646.3 5667.9 5671.5 5461.9 5561.7 5644.2 5685.1 5694.1 5249.3 5345.7 5369.5 5373.6 5385.2 5862.0 5874.5 5879.2 5894.6 5897.0 5329.2 5498.7 5556.8 5649.1 5652.0 5690.8 5708.1 5744.7 5757.6 5761.8 5692.9 5693.9 5701.5 5707.2 5708.6 5478.7 5559.1 5605.7 5624.3 5690.9 4323.0 4339.7 4340.0 4343.3 4377.8 3864.2 3884.3 3907.4 3911.3 3912.8 5206.7 5268.0 5286.9 5337.5 5343.2 5723.9 5732.7 5738.9 5741.9 5750.7 5334.2 5380.9 5385.3 5385.4 5431.1 4588.6 4689.3 4704.7 4733.1 4765.6 5970.2 5973.6 5979.9 5982.6 5985.3 5539.6 5772.4 5778.9 5784.7 5788.6 5809.8 5837.3 5838.4 5910.7 5920.2 5609.5 5627.7 5630.1 5631.2 5634.0 5529.4 5629.9 5718.5 5733.0 5733.1 5528.4 5570.1 5575.1 5581.2 5621.0 5559.1 5565.4 5565.6 5568.7 5571.4 5283.9 5395.2 5431.7 5444.4 5554.2 5636.9 5646.8 5648.8 5649.2 5666.7 5492.5 5494.7 5496.0 5497.4 5497.8 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#1] ext.html Cycles:180 Average:59700.14 Median:172074.04 stddev:117911.07 (68.5%) stddev-sans-first:118158.36 02:20:09 INFO - PROCESS | 12658 | Values: 606.4 629.4 638.4 639.9 657.8 33957.8 43957.6 44598.6 44751.6 44802.3 45620.5 46234.2 46303.3 46315.0 46378.1 7882.2 8709.3 8893.2 8911.5 10411.1 10053.1 10519.2 10521.3 10522.6 10523.3 10582.5 10639.8 10641.7 10646.0 10654.4 10546.5 10567.3 10587.8 10600.6 10608.6 10395.4 10456.2 10470.9 10474.6 10486.1 41089.4 41416.8 41625.8 41643.4 41651.0 3255.4 3377.5 3397.1 3437.9 3492.2 33050.5 33088.5 33387.7 33388.0 34436.8 4331.7 4340.3 4341.9 4374.4 4380.0 338274.0 338422.0 339275.0 339420.0 340751.0 59321.0 59341.4 59568.7 59658.7 59912.7 31458.2 31986.8 32042.4 33488.8 33596.5 15871.8 15924.8 15953.5 15956.2 15985.8 11279.4 11743.1 11821.5 11845.3 12784.9 19741.5 19937.6 20063.6 20079.6 20203.7 6063.4 7175.8 7214.5 7237.8 7329.2 984.3 991.5 1036.3 1101.7 1123.7 32673.3 32933.7 33326.5 33327.2 33651.5 1100.3 1101.9 1180.1 1200.1 1210.7 17068.0 17174.9 17232.9 17380.3 17610.6 522697.0 524625.0 526984.0 529153.0 529616.0 59206.4 59836.7 59908.4 59935.7 59954.7 1330.7 1361.1 1367.2 1376.3 1379.6 30951.0 31070.7 32214.4 32501.2 32868.2 52861.5 53468.0 53497.5 53514.5 53564.5 442021.0 449755.0 450058.0 451342.0 451615.0 25287.6 27956.3 28330.9 28699.0 29736.0 47658.5 48367.0 48447.5 49127.3 50015.7 38475.8 41190.6 41434.4 41990.8 42143.8 41333.6 41488.0 41842.8 42375.8 42564.1 37310.8 40790.0 41440.4 41678.8 41707.2 35554.8 36718.8 36918.9 37198.1 37483.6 28116.7 28331.3 28336.4 28390.5 28508.1 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#2] jquery.html Cycles:180 Average:28157.45 Median:11118.21 stddev:74900.87 (673.7%) stddev-sans-first:75081.92 02:20:09 INFO - PROCESS | 12658 | Values: 366.0 379.1 390.9 391.0 405.0 17080.7 18657.3 19929.5 19997.5 20209.9 18813.9 18981.2 19436.8 19546.1 19726.7 5649.6 5731.7 5792.7 5855.8 5899.6 5699.0 5725.7 5787.6 5792.5 5828.0 5782.2 5812.6 5819.1 5833.1 5851.7 5614.7 5783.9 5790.9 5794.3 5817.4 4969.1 5195.1 5242.1 5277.4 5353.1 13321.7 13342.3 13345.8 19044.0 21928.7 2157.5 2202.6 2267.3 2278.1 2337.8 9827.5 9863.0 9911.0 10314.3 10363.3 1757.2 1817.4 1866.3 1877.1 1973.1 77527.6 77968.2 78422.0 78652.6 79613.6 8834.7 9304.4 9386.2 9866.6 10106.9 13080.1 13113.2 13148.2 13230.5 13241.5 7480.9 7631.8 7731.1 7809.8 7830.2 7636.4 7687.2 7737.7 7814.9 7827.0 4100.3 4112.3 4116.5 4127.3 4151.0 1937.5 2001.2 2009.4 2017.5 2026.5 937.8 995.4 1043.9 1075.8 1096.7 18943.9 19565.5 19774.5 19781.2 19872.9 962.6 1010.0 1016.1 1022.7 1052.7 10636.9 10900.5 11006.1 11007.8 11056.7 450227.0 450607.0 450702.0 454078.0 456707.0 95580.5 96979.5 97202.0 98863.0 98905.5 995.8 1015.7 1017.6 1021.9 1026.9 16976.7 17364.8 17659.2 17673.9 17758.8 40600.4 41005.8 41871.9 42659.8 42827.6 58255.7 58655.0 60310.4 60312.7 60433.7 8870.9 12099.9 12906.4 13076.3 13351.1 13053.4 13726.2 13863.4 14490.1 14696.2 11591.0 12434.6 12493.4 12774.2 12839.2 12628.2 12904.7 13104.2 13141.7 13188.0 13138.9 13243.8 13307.4 13358.3 13360.3 13130.0 13141.7 13154.2 13243.3 13384.3 12910.0 13089.7 13129.0 13130.5 13240.6 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#3] mootools.html Cycles:180 Average:5568.00 Median:5193.01 stddev:3146.12 (60.6%) stddev-sans-first:3139.07 02:20:09 INFO - PROCESS | 12658 | Values: 1362.6 1434.4 1500.4 1611.5 1802.1 8073.5 8390.8 8420.2 8621.2 8621.3 8333.9 8523.0 8537.0 8539.0 8551.0 2007.6 2259.4 2302.7 2328.5 2333.9 2392.9 2394.0 2394.7 2401.4 2405.9 2318.7 2320.7 2346.0 2350.1 2352.5 1963.1 2209.0 2227.4 2266.0 2269.9 2275.9 2279.7 2298.2 2306.4 2307.7 8541.7 8586.9 8599.9 8602.3 8613.8 5083.8 5184.3 5201.7 5208.6 5216.7 3127.4 3203.1 3233.9 3406.8 3444.2 991.0 992.8 999.3 1008.6 1050.1 11293.6 11535.3 11641.9 11987.6 11995.9 4449.4 4471.9 4528.7 4532.0 4540.8 9337.3 9386.2 9386.5 9398.4 9417.8 5225.8 5229.1 5230.5 5231.3 5237.2 4179.2 4744.8 4829.0 4834.6 4950.0 3822.6 3881.3 3928.4 4017.0 4057.0 1160.9 1163.1 1170.8 1182.5 1202.1 702.7 784.4 825.3 856.2 924.1 5502.6 5566.9 5581.9 5777.6 5787.0 931.5 983.5 988.1 989.9 1002.1 3712.6 3717.7 3800.2 3819.2 3893.6 10347.9 10592.2 10617.3 10660.4 10678.6 9946.3 10524.4 10632.5 10771.5 10784.7 8005.4 8321.8 8392.3 8406.0 8410.2 5250.6 5341.6 5718.0 5977.4 6051.3 9695.5 9924.8 9969.4 9977.9 10016.4 9416.7 9647.2 9696.3 9778.5 10050.3 6602.3 7040.3 7186.0 7484.0 7664.3 7915.2 8121.5 8145.1 8167.3 8182.5 6936.1 7112.4 7148.8 7155.4 7294.5 7066.5 7081.4 7106.1 7213.8 7215.1 6215.1 6405.6 6408.2 6506.1 6524.7 4936.7 4949.7 4979.9 4993.0 4996.2 4690.7 4742.8 4968.9 5067.6 5154.1 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#4] prototype.html Cycles:180 Average:4645.39 Median:5310.71 stddev:1375.66 (25.9%) stddev-sans-first:1340.43 02:20:09 INFO - PROCESS | 12658 | Values: 307.3 308.1 313.6 316.9 320.3 5292.4 5307.0 5335.3 5362.3 5364.9 5209.4 5233.0 5241.2 5264.3 5311.5 3893.7 3961.8 4072.8 4079.8 4105.3 4116.9 4119.3 4119.8 4130.4 4138.5 3940.8 4093.5 4096.9 4100.9 4130.6 3973.9 4112.2 4112.5 4125.8 4139.1 3636.4 3643.3 3660.2 3662.7 3672.2 5055.0 5063.3 5076.3 5113.3 5125.0 4512.3 4676.5 4682.8 4709.7 4757.2 5349.6 5386.5 5398.5 5403.6 5418.9 3960.5 3983.2 3986.6 3993.2 4016.7 5384.5 5693.9 5718.5 5721.9 5728.0 3914.0 3929.7 3937.3 3938.9 3941.9 3975.8 4011.9 4023.6 4034.6 4039.2 4493.7 4532.0 4562.2 4673.5 4680.7 5472.3 5524.3 5539.9 5545.8 5549.1 1422.5 1439.6 1439.7 1453.7 1461.6 922.8 930.8 939.5 950.2 965.9 5131.8 5285.8 5290.8 5300.6 5328.7 5586.7 5628.9 5631.6 5633.7 5673.6 5179.0 5305.3 5309.3 5312.3 5318.8 2970.7 2971.3 2985.9 2993.8 3024.6 5556.9 5810.4 5838.7 5898.4 5902.0 5717.5 5832.8 5863.7 5868.7 5888.8 5838.9 5843.4 5888.8 5923.1 5939.4 5378.0 5643.8 5678.6 5697.6 5741.0 5594.0 5596.3 5597.9 5607.5 5633.4 5751.4 5954.1 5976.6 5996.2 6007.9 3901.8 3939.8 3943.2 3945.0 3968.3 5699.7 5736.0 5742.3 5763.6 5798.9 5290.2 5604.0 5614.9 5627.6 5631.2 5534.5 5552.7 5570.8 5574.5 5604.0 5292.7 5309.9 5520.9 5522.9 5533.3 5526.1 5578.9 5588.4 5605.7 5612.6 5399.5 5424.3 5447.3 5459.6 5486.3 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - PROCESS | 12658 | [#5] yui.html Cycles:180 Average:15276.00 Median:24815.35 stddev:18900.12 (76.2%) stddev-sans-first:18921.54 02:20:09 INFO - PROCESS | 12658 | Values: 721.3 728.9 791.6 799.1 810.4 13535.5 13667.9 13738.1 13905.3 14023.6 13848.4 13886.3 14019.3 14020.6 14023.9 680.0 787.8 796.0 829.0 832.4 803.2 812.0 812.4 813.8 814.3 839.4 841.1 841.6 841.8 842.6 707.4 817.1 821.2 843.1 843.7 605.8 606.0 606.6 608.3 609.4 13537.3 13540.5 13545.3 13548.0 13583.0 13113.3 13361.5 13406.9 13460.2 13760.8 11823.9 11833.9 11924.3 11941.1 11976.6 4394.7 4446.0 4467.6 4506.4 4624.3 58577.0 59212.0 59241.7 60399.0 61121.0 11160.6 11241.8 11272.6 11310.9 11402.9 20498.7 20560.7 20569.5 20574.0 20593.9 7661.8 7663.4 7827.6 7977.1 8251.3 4417.1 4420.0 4479.8 4496.8 4583.7 3299.3 3412.6 3414.0 3414.9 3415.3 553.0 555.5 606.6 635.5 650.8 519.2 573.1 657.0 659.8 734.8 8697.5 9037.5 9054.0 9139.9 9159.9 628.9 653.5 686.6 688.1 708.5 4354.6 4382.5 4401.3 4450.6 4485.4 69749.0 70702.6 70893.0 71346.0 72286.6 45719.3 46742.0 48624.5 62291.7 62472.7 56615.2 57327.7 57683.0 57902.4 58798.0 8580.9 8677.2 8716.9 8733.6 8756.2 39421.4 39705.6 39742.8 39754.8 40129.2 44275.3 45166.1 46092.5 49111.5 53311.0 10702.7 11017.7 11037.7 11058.2 11081.4 11450.6 11494.5 11551.2 11561.7 11938.4 10900.3 10918.5 10978.1 11072.3 11249.8 10677.5 10775.9 10864.0 10937.9 11064.1 9968.8 10292.9 10341.8 10575.4 10612.2 9318.4 9423.1 9513.7 9610.5 9670.1 9260.3 9393.2 9408.3 9444.0 9468.4 02:20:09 INFO - PROCESS | 12658 | -------- Summary: end -------- 02:20:09 INFO - PROCESS | 12658 | 02:20:09 INFO - TEST-INFO | 12658: exit 0 02:20:09 INFO - TEST-OK | dromaeo_css | took 1112011ms 02:20:09 INFO - TEST-START | kraken 02:20:09 INFO - operating with platform_type : linux_ 02:20:09 INFO - Initialising browser for kraken test... 02:20:09 INFO - TEST-INFO | started process 12838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebWC2a/profile http://localhost:40820/getInfo.html) 02:20:13 INFO - PROCESS | 12838 | __metrics Screen width/height:1600/1200 02:20:13 INFO - PROCESS | 12838 | colorDepth:24 02:20:13 INFO - PROCESS | 12838 | Browser inner width/height: 1024/697 02:20:13 INFO - PROCESS | 12838 | __metrics 02:20:15 ERROR - PROCESS | 12838 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:20:16 INFO - TEST-INFO | 12838: exit 0 02:20:16 INFO - Browser initialized. 02:20:16 INFO - Running cycle 1/1 for kraken test... 02:20:16 INFO - TEST-INFO | started process 12921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebWC2a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:27 INFO - PROCESS | 12921 | RSS: Main: 153309184 02:20:27 INFO - PROCESS | 12921 | 02:20:30 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40820/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:31 INFO - PROCESS | 12921 | RSS: Main: 209670144 02:20:31 INFO - PROCESS | 12921 | 02:20:34 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40820/tests/kraken/driver.html?testName=audio-dft) 02:20:34 INFO - PROCESS | 12921 | RSS: Main: 198868992 02:20:34 INFO - PROCESS | 12921 | 02:20:37 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40820/tests/kraken/driver.html?testName=audio-fft) 02:20:38 INFO - PROCESS | 12921 | RSS: Main: 266973184 02:20:38 INFO - PROCESS | 12921 | 02:20:40 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40820/tests/kraken/driver.html?testName=audio-oscillator) 02:20:41 INFO - PROCESS | 12921 | RSS: Main: 175788032 02:20:41 INFO - PROCESS | 12921 | 02:20:43 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:44 INFO - PROCESS | 12921 | RSS: Main: 179654656 02:20:44 INFO - PROCESS | 12921 | 02:20:47 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40820/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:47 INFO - PROCESS | 12921 | RSS: Main: 214667264 02:20:47 INFO - PROCESS | 12921 | 02:20:51 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40820/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:52 INFO - PROCESS | 12921 | RSS: Main: 213585920 02:20:52 INFO - PROCESS | 12921 | 02:20:55 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40820/tests/kraken/driver.html?testName=json-parse-financial) 02:20:55 INFO - PROCESS | 12921 | RSS: Main: 214458368 02:20:55 INFO - PROCESS | 12921 | 02:20:57 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:57 INFO - PROCESS | 12921 | RSS: Main: 203599872 02:20:57 INFO - PROCESS | 12921 | 02:20:59 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:00 INFO - PROCESS | 12921 | RSS: Main: 206929920 02:21:00 INFO - PROCESS | 12921 | 02:21:02 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:03 INFO - PROCESS | 12921 | RSS: Main: 217190400 02:21:03 INFO - PROCESS | 12921 | 02:21:05 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:06 INFO - PROCESS | 12921 | RSS: Main: 224833536 02:21:06 INFO - PROCESS | 12921 | 02:21:09 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:09 INFO - PROCESS | 12921 | RSS: Main: 221712384 02:21:09 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | Cycle 1(1): loaded http://localhost:40820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40820/tests/kraken/driver.html?testName=ai-astar) 02:21:11 INFO - PROCESS | 12921 | RSS: Main: 267948032 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | __start_tp_report 02:21:11 INFO - PROCESS | 12921 | _x_x_mozilla_page_load 02:21:11 INFO - PROCESS | 12921 | _x_x_mozilla_page_load_details 02:21:11 INFO - PROCESS | 12921 | |i|pagename|runs| 02:21:11 INFO - PROCESS | 12921 | |0;ai-astar;110;105;110;109;111;112;110;110;109;110 02:21:11 INFO - PROCESS | 12921 | |1;audio-beat-detection;157;124;157;207;126;152;163;131;176;126 02:21:11 INFO - PROCESS | 12921 | |2;audio-dft;160;163;161;161;159;161;161;161;161;162 02:21:11 INFO - PROCESS | 12921 | |3;audio-fft;74;75;75;155;75;75;76;75;137;75 02:21:11 INFO - PROCESS | 12921 | |4;audio-oscillator;93;92;150;92;93;94;125;92;92;116 02:21:11 INFO - PROCESS | 12921 | |5;imaging-gaussian-blur;117;117;116;116;117;116;116;118;117;117 02:21:11 INFO - PROCESS | 12921 | |6;imaging-darkroom;146;145;146;145;145;145;146;146;146;145 02:21:11 INFO - PROCESS | 12921 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 02:21:11 INFO - PROCESS | 12921 | |8;json-parse-financial;57;57;56;55;57;56;56;120;57;59 02:21:11 INFO - PROCESS | 12921 | |9;json-stringify-tinderbox;62;61;62;61;61;61;62;61;63;61 02:21:11 INFO - PROCESS | 12921 | |10;stanford-crypto-aes;78;79;79;79;79;80;80;80;81;81 02:21:11 INFO - PROCESS | 12921 | |11;stanford-crypto-ccm;123;121;128;119;125;132;126;120;201;122 02:21:11 INFO - PROCESS | 12921 | |12;stanford-crypto-pbkdf2;162;171;160;164;162;165;161;158;161;164 02:21:11 INFO - PROCESS | 12921 | |13;stanford-crypto-sha256-iterative;62;63;63;63;63;61;62;62;60;62 02:21:11 INFO - PROCESS | 12921 | __end_tp_report 02:21:11 INFO - PROCESS | 12921 | __start_cc_report 02:21:11 INFO - PROCESS | 12921 | _x_x_mozilla_cycle_collect,1881 02:21:11 INFO - PROCESS | 12921 | __end_cc_report 02:21:11 INFO - PROCESS | 12921 | __startTimestamp1463736071772__endTimestamp 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | ------- Summary: start ------- 02:21:11 INFO - PROCESS | 12921 | Number of tests: 14 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 02:21:11 INFO - PROCESS | 12921 | Values: 110.0 105.0 110.0 109.0 111.0 112.0 110.0 110.0 109.0 110.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:157.00 stddev:26.56 (16.9%) stddev-sans-first:28.11 02:21:11 INFO - PROCESS | 12921 | Values: 157.0 124.0 157.0 207.0 126.0 152.0 163.0 131.0 176.0 126.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 02:21:11 INFO - PROCESS | 12921 | Values: 160.0 163.0 161.0 161.0 159.0 161.0 161.0 161.0 161.0 162.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#3] audio-fft Cycles:10 Average:89.20 Median:75.00 stddev:30.24 (40.3%) stddev-sans-first:31.57 02:21:11 INFO - PROCESS | 12921 | Values: 74.0 75.0 75.0 155.0 75.0 75.0 76.0 75.0 137.0 75.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:92.00 stddev:20.05 (21.8%) stddev-sans-first:20.88 02:21:11 INFO - PROCESS | 12921 | Values: 93.0 92.0 150.0 92.0 93.0 94.0 125.0 92.0 92.0 116.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:21:11 INFO - PROCESS | 12921 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 116.0 118.0 117.0 117.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:21:11 INFO - PROCESS | 12921 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:21:11 INFO - PROCESS | 12921 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:57.00 stddev:20.06 (35.2%) stddev-sans-first:21.15 02:21:11 INFO - PROCESS | 12921 | Values: 57.0 57.0 56.0 55.0 57.0 56.0 56.0 120.0 57.0 59.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:21:11 INFO - PROCESS | 12921 | Values: 62.0 61.0 62.0 61.0 61.0 61.0 62.0 61.0 63.0 61.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:0.97 (1.2%) stddev-sans-first:0.83 02:21:11 INFO - PROCESS | 12921 | Values: 78.0 79.0 79.0 79.0 79.0 80.0 80.0 80.0 81.0 81.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:125.50 stddev:24.67 (19.7%) stddev-sans-first:25.96 02:21:11 INFO - PROCESS | 12921 | Values: 123.0 121.0 128.0 119.0 125.0 132.0 126.0 120.0 201.0 122.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:3.55 (2.2%) stddev-sans-first:3.76 02:21:11 INFO - PROCESS | 12921 | Values: 162.0 171.0 160.0 164.0 162.0 165.0 161.0 158.0 161.0 164.0 02:21:11 INFO - PROCESS | 12921 | 02:21:11 INFO - PROCESS | 12921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:0.99 (1.6%) stddev-sans-first:1.05 02:21:11 INFO - PROCESS | 12921 | Values: 62.0 63.0 63.0 63.0 63.0 61.0 62.0 62.0 60.0 62.0 02:21:11 INFO - PROCESS | 12921 | -------- Summary: end -------- 02:21:11 INFO - PROCESS | 12921 | 02:21:12 INFO - TEST-INFO | 12921: exit 0 02:21:12 INFO - TEST-OK | kraken | took 62915ms 02:21:12 INFO - SUITE-END | took 1174s 02:21:12 INFO - Completed test suite (00:19:35) 02:21:12 INFO - javascript benchmark 02:21:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.43141518819, 3083.845807709615, 3104.8913288034923, 3106.6582675905647, 3145.4180976519347, 5140.331756871611, 5167.9741601292035, 5221.0, 5330.600204984622, 5337.14605663094, 5259.053370393337, 5288.312519372476, 5306.628536002481, 5334.706591137486, 5382.085045542258, 4733.739644319561, 4820.734859582722, 4833.661643684944, 4846.7818948147415, 4981.153203955337, 4772.761361931907, 4779.402574678165, 4811.831585894494, 4824.0, 4852.078105160026, 4667.743274119922, 4706.10583989041, 4743.762811859393, 4750.76246187691, 4813.446453657839, 4736.905261894777, 4749.572538471554, 4778.784954677048, 4824.107540105092, 4855.757212139414, 4645.581897629229, 4762.214234651278, 4778.4982576829625, 4788.928166077511, 4832.710037397767, 5135.0500157470615, 5201.921971170435, 5204.4535323791215, 5288.048151332759, 5296.152615581488, 5633.15502674598, 5644.74598643062, 5646.26598542191, 5667.8583035424035, 5671.517920976722, 5461.863453413696, 5561.749721262553, 5644.153376993443, 5685.147227915804, 5694.1458781183155, 5249.317588713481, 5345.705986170759, 5369.516743493065, 5373.596980226538, 5385.246065550826, 5862.003459411911, 5874.500667443315, 5879.206307148565, 5894.557908156906, 5896.997510423238, 5329.173978033411, 5498.697571633598, 5556.833295001156, 5649.12438572022, 5652.0391533439415, 5690.800821971294, 5708.0581704019205, 5744.655320680772, 5757.568182386338, 5761.769529218868, 5692.857678558069, 5693.857653558612, 5701.486866182064, 5707.229524014288, 5708.628939118944, 5478.671279723229, 5559.054960656698, 5605.663660180402, 5624.325080990226, 5690.857728556736, 4323.027318853296, 4339.7396156230725, 4339.9783001085425, 4343.305071188658, 4377.781110944504, 3864.2271545690974, 3884.3008258513173, 3907.3943538751537, 3911.3350730375337, 3912.8043597819997, 5206.739663016834, 5268.0, 5286.867828304246, 5337.466253374631, 5343.171808369631, 5723.856903577361, 5732.656040637575, 5738.885222295531, 5741.942580574224, 5750.712464376765, 5334.1732031535175, 5380.865478362994, 5385.299911011622, 5385.380681221632, 5431.131019037014, 4588.564086411786, 4689.296605509133, 4704.717716936994, 4733.100710864925, 4765.571098601143, 5970.194023806817, 5973.641581505123, 5979.850503737442, 5982.551308651781, 5985.281766188085, 5539.556835453234, 5772.3938986406665, 5778.942210578009, 5784.681842498703, 5788.594798364243, 5809.796657116981, 5837.328707198726, 5838.4453476919625, 5910.734016969161, 5920.200772895604, 5609.467100625434, 5627.690477023639, 5630.127330263816, 5631.211630371669, 5634.0, 5529.391766905717, 5629.88740225185, 5718.51392631631, 5733.0, 5733.0540460823495, 5528.44715528444, 5570.053090974625, 5575.080111781511, 5581.246531718166, 5621.0, 5559.11054231321, 5565.3599836019375, 5565.6104072714525, 5568.693721845338, 5571.3871474137, 5283.9432113578205, 5395.2176934343515, 5431.701256430934, 5444.373897001896, 5554.166874968787, 5636.943630563642, 5646.774129034792, 5648.774049037993, 5649.180868774087, 5666.744996475086, 5492.47821456961, 5494.670319780826, 5495.972520137374, 5497.422770609029, 5497.8075767347955], "value": 5225.09548497282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3512042114936, 629.4209327418774, 638.4062821575935, 639.9392057754518, 657.7763560389467, 33957.830210848944, 43957.56042439575, 44598.55401445985, 44751.55248447515, 44802.32796508055, 45620.54379456204, 46234.225946443155, 46303.30545041827, 46315.0, 46378.072438551295, 7882.2117788221, 8709.346798990086, 8893.244074253664, 8911.509866957314, 10411.06300432961, 10053.145482633949, 10519.158467322633, 10521.316114452575, 10522.631707890225, 10523.315984461024, 10582.470876456186, 10639.840402393971, 10641.73395665107, 10646.0, 10654.360738355685, 10546.47267636619, 10567.26029177958, 10587.788244235073, 10600.628977985734, 10608.575656973711, 10395.376277423378, 10456.163506919429, 10470.947645261725, 10474.633387831389, 10486.056254937015, 41089.38365924513, 41416.79291603553, 41625.79187104045, 41643.37534936978, 41651.0, 3255.430299697567, 3377.4764911438765, 3397.0741329242223, 3437.862485500577, 3492.1618811485314, 33050.504242436386, 33088.52570480113, 33387.6661233387, 33388.0, 34436.82781586101, 4331.653467722606, 4340.305551111807, 4341.869743907688, 4374.4094547236355, 4380.036391993756, 338274.0, 338422.0, 339275.0, 339420.0, 340751.0, 59321.0, 59341.40658593445, 59568.70215648981, 59658.70170649119, 59912.70043649841, 31458.213544661565, 31986.84006579999, 32042.359152816814, 33488.83255583706, 33596.49605255923, 15871.841281587267, 15924.840751592568, 15953.521394358188, 15956.202189890459, 15985.760213596805, 11279.379634120201, 11743.11926605508, 11821.468033938494, 11845.289282642896, 12784.872151278369, 19741.506462338555, 19937.60124797525, 20063.598728025358, 20079.59840803205, 20203.696944545845, 6063.421188011057, 7175.7709030936285, 7214.458915581247, 7237.819054523679, 7329.230430804795, 984.2863923655435, 991.4596544883057, 1036.2538971940191, 1101.730076131337, 1123.6966019174777, 32673.34653306968, 32933.67066329306, 33326.50010249848, 33327.176609775524, 33651.495227571606, 1100.3287994323457, 1101.8787933327328, 1180.1208099965409, 1200.1239095460362, 1210.727586293077, 17068.0, 17174.914125429543, 17232.913835430994, 17380.3047878086, 17610.559736006704, 522697.0, 524625.0, 526984.0, 529153.0, 529616.0, 59206.40793592095, 59836.70081649564, 59908.40091599115, 59935.700321498116, 59954.700226498586, 1330.7072444062292, 1361.1084739495645, 1367.1865240182076, 1376.2843321472778, 1379.5723325768843, 30951.0, 31070.689293106778, 32214.355712885143, 32501.18747031343, 32868.178295542806, 52861.471385287194, 53468.0, 53497.46502535081, 53514.46485535095, 53564.46435535595, 442021.0, 449755.0, 450058.0, 451342.0, 451615.0, 25287.620685690097, 27956.30109247285, 28330.858345708963, 28699.0, 29736.0, 47658.523414766794, 48367.0, 48447.5155248443, 49127.26309105438, 50015.749921250164, 38475.807620961714, 41190.58809411868, 41434.36177548938, 41990.79004604957, 42143.789281053396, 41333.58666413297, 41488.0, 41842.79078604587, 42375.788121059195, 42564.1487170261, 37310.813445932596, 40789.98025049397, 41440.3783943235, 41678.79160604178, 41707.16585668331, 35554.82222588974, 36718.8164059178, 36918.94026098656, 37198.070048249014, 37483.625163748016, 28116.71883281141, 28331.291717707223, 28336.433271334045, 28390.4511936008, 28508.144755657362], "value": 20270.1355332486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.0409726516524, 379.11854937270834, 390.93158697227994, 390.97849618271, 404.9939250911235, 17080.743788843163, 18657.34699285525, 19929.501762455944, 19997.500062498446, 20209.898950505263, 18813.905930470362, 18981.247719080726, 19436.805631943713, 19546.12042458089, 19726.70409943852, 5649.6327738696855, 5731.684757338345, 5792.652440853562, 5855.76576936922, 5899.557533185007, 5699.03116470199, 5725.685087320196, 5787.594868359217, 5792.536597072245, 5828.03837366834, 5782.219400380936, 5812.622179558336, 5819.068948968166, 5833.066709326508, 5851.7074146292725, 5614.719264036802, 5783.942160578404, 5790.913136302916, 5794.304683437972, 5817.360090390075, 4969.0807200668, 5195.064888320101, 5242.108841496916, 5277.366715994067, 5353.063213937584, 13321.733565328735, 13342.266175360352, 13345.799813002814, 19044.0, 21928.671069933964, 2157.4822042709793, 2202.64757638777, 2267.251806903718, 2278.054607337953, 2337.777911098443, 9827.459489728062, 9863.0, 9911.0, 10314.349704047392, 10363.274570780048, 1757.2443849144863, 1817.3820900893627, 1866.318793640325, 1877.098992483602, 1973.1219607274768, 77527.61236193783, 77968.22031779723, 78422.0, 78652.60673696594, 79613.60193198996, 8834.734957951272, 9304.441733496013, 9386.249100071978, 9866.556004979793, 10106.898931010743, 13080.149790263793, 13113.213207207598, 13148.211107333591, 13230.536931207555, 13241.536546221028, 7480.925190748023, 7631.809204769926, 7731.110922244014, 7809.843803123906, 7830.2169783021245, 7636.3890888728765, 7687.154413014564, 7737.729179478803, 7814.921850781419, 7827.0, 4100.282450571138, 4112.3420252759415, 4116.5060192777055, 4127.33962565994, 4151.045259590251, 1937.4962509747568, 2001.229526632228, 2009.3770931011434, 2017.5157962089286, 2026.5136367271748, 937.7936853892132, 995.382862625177, 1043.9060484556426, 1075.8171110911164, 1096.7203363142507, 18943.905280473784, 19565.51086222856, 19774.505637358892, 19781.208751649774, 19872.90063549702, 962.6005207838668, 1009.9545520451597, 1016.0855230292796, 1022.6880801355658, 1052.6999805055675, 10636.946815265874, 10900.50947707355, 11006.119510439306, 11007.834882476769, 11056.668299951014, 450227.0, 450607.0, 450702.0, 454078.0, 456707.0, 95580.52209738907, 96979.51510242544, 97202.0, 98863.0, 98905.50547247361, 995.8107959487675, 1015.6952914125881, 1017.5726194998118, 1021.8722659667542, 1026.9075783179549, 16976.660466790843, 17364.7639457108, 17659.205335759663, 17673.911630441766, 17758.822411776233, 40600.39099413452, 41005.79497102495, 41871.85961052872, 42659.78670106754, 42827.57172428236, 58255.70872145782, 58655.0, 60310.39689603048, 60312.69843650753, 60433.69783151056, 8870.866936996079, 12099.879001209874, 12906.35468226566, 13076.346182690637, 13351.132176408502, 13053.412596433373, 13726.245056521988, 13863.4454621814, 14490.130592164503, 14696.191709455656, 11591.0, 12434.626961190817, 12493.43779529905, 12774.23354598727, 12839.165454245443, 12628.242305461701, 12904.741905162033, 13104.2137471752, 13141.737165256833, 13188.0, 13138.934305328412, 13243.801342980056, 13307.401166947317, 13358.332083395597, 13360.331983400985, 13130.0, 13141.671458213239, 13154.21074735519, 13243.337833108499, 13384.263865487492, 12910.0, 13089.672758181121, 13129.0, 13130.474781008652, 13240.602781916557], "value": 9304.706248439416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.611655678132, 1434.3545404567947, 1500.422337400101, 1611.5084899105768, 1802.143981608736, 8073.51558906466, 8390.79023024424, 8420.200080992303, 8621.224089831914, 8621.267192288664, 8333.874991875111, 8523.0, 8536.95731521343, 8539.0, 8550.973883134033, 2007.6486614842418, 2259.367377134405, 2302.712160979882, 2328.5342931413784, 2333.88330583471, 2392.9162479313227, 2393.964090538643, 2394.724606670238, 2401.387646150229, 2405.891734871935, 2318.6869772580653, 2320.721513418384, 2346.0, 2350.059976009601, 2352.494213744045, 1963.1460314763053, 2208.9668654970187, 2227.354067320475, 2266.0482597309006, 2269.931902042941, 2275.8634481931135, 2279.680844681746, 2298.195631528968, 2306.3542208181734, 2307.734610519795, 8541.658333666646, 8586.87119693205, 8599.914000859973, 8602.2688071514, 8613.784655383603, 5083.822066227701, 5184.300119483897, 5201.713905735183, 5208.635395522277, 5216.739163041832, 3127.390158919012, 3203.0711093782775, 3233.8868139615, 3406.812625305607, 3444.2078321986082, 990.9594925328377, 992.846108853129, 999.3154689037959, 1008.5915204342253, 1050.0759331787979, 11293.60472383471, 11535.307881527135, 11641.883581164164, 11987.580434684744, 11995.940020299842, 4449.377087207794, 4471.8658440246845, 4528.728276303433, 4532.002959348938, 4540.79566419512, 9337.299702522203, 9386.20217281525, 9386.483743394043, 9398.389104708172, 9417.76455588602, 5225.790968361299, 5229.137192363293, 5230.529252367305, 5231.293775340357, 5237.214417837355, 4179.226843034048, 4744.7627618618935, 4828.95171048292, 4834.6374021947795, 4949.950500495021, 3822.57951625321, 3881.262560113626, 3928.3910993796007, 4016.979915100406, 4057.046594050396, 1160.9419529023514, 1163.1276542593055, 1170.7834050700649, 1182.5269892043252, 1202.0683969923205, 702.6592102830124, 784.4273680213477, 825.2778818533783, 856.1566856646199, 924.117467818232, 5502.614816962774, 5566.888662226733, 5581.944180558143, 5777.624454410534, 5787.0, 931.4783721116197, 983.4836710726926, 988.0761488008735, 989.9158571521357, 1002.1281485107856, 3712.5916149223563, 3717.683996860243, 3800.239952009609, 3819.1788765415567, 3893.5717071122153, 10347.94826025865, 10592.15262778976, 10617.256792024484, 10660.360378377321, 10678.572857085785, 9946.254030947563, 10524.36853788775, 10632.521536530874, 10771.515281812337, 10784.676459706221, 8005.439619226599, 8321.791955201168, 8392.32861371101, 8405.95797021011, 8410.243078122876, 5250.579953603627, 5341.572674185978, 5717.970765262293, 5977.432143946318, 6051.304100028553, 9695.466749328854, 9924.801503970024, 9969.40183588987, 9977.850332245167, 10016.449095299537, 9416.717498475056, 9647.228221742103, 9696.321257511907, 9778.511074446107, 10050.296479246383, 6602.316409315594, 7040.260772619006, 7185.964070179615, 7484.0, 7664.34853037498, 7915.208479152038, 8121.4721043132, 8145.104038555873, 8167.264946154874, 8182.509049457051, 6936.132983377078, 7112.35988761014, 7148.821279468055, 7155.391791697764, 7294.489385742947, 7066.4700147490175, 7081.433485321265, 7106.111736032996, 7213.783586492414, 7215.098112735908, 6215.06773983906, 6405.615663060045, 6408.166938297992, 6506.056621789909, 6524.67376631176, 4936.703797772145, 4949.678270912379, 4979.879527106372, 4993.026359859792, 4996.15065438869, 4690.742009189527, 4742.762861856824, 4968.8757781055765, 5067.645264831426, 5154.1237989542615], "value": 4458.265465014408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.3453543951385, 308.1372157957718, 313.6032918358276, 316.8985924504159, 320.322517874695, 5292.364916210051, 5307.0, 5335.253064570953, 5362.28406909789, 5364.91952620711, 5209.374875015003, 5233.0, 5241.161414173733, 5264.289320941672, 5311.49540793625, 3893.688504919614, 3961.8114565630194, 4072.839240816368, 4079.7556745192705, 4105.275784170655, 4116.855910043149, 4119.258533463975, 4119.8352065917325, 4130.421740956269, 4138.461999940004, 3940.8177546736006, 4093.5497095319492, 4096.927304521609, 4100.876973690794, 4130.607592278729, 3973.9205215895663, 4112.198121366335, 4112.540048282876, 4125.793710314502, 4139.089400331953, 3636.381815091441, 3643.2713457308646, 3660.158163622382, 3662.7436079474446, 3672.2288319452946, 5055.0, 5063.316452278968, 5076.340075790161, 5113.335266415379, 5124.975004999015, 4512.255477846152, 4676.5089665584965, 4682.765861706901, 4709.670323077386, 4757.238841785298, 5349.5720342372515, 5386.461353864583, 5398.46015398457, 5403.621746477748, 5418.91871621926, 3960.5049368828895, 3983.24318379507, 3986.5614782373914, 3993.24128415603, 4016.6585840203616, 5384.488473595042, 5693.943060569382, 5718.485336319751, 5721.885562288772, 5727.9952016794205, 3914.041059940333, 3929.7445666031617, 3937.330653788863, 3938.932060668115, 3941.8620348287673, 3975.840966361371, 4011.859584914514, 4023.5775243599587, 4034.5561988181275, 4039.1517781265675, 4493.73037617744, 4532.0, 4562.24722920721, 4673.462551806586, 4680.7191568506, 5472.261244731911, 5524.281843360337, 5539.9169012464845, 5545.805896793593, 5549.139883318092, 1422.5418945580861, 1439.5609339151658, 1439.7048605035943, 1453.738327101132, 1461.6199788055183, 922.7819278552247, 930.8277968575835, 939.5349302095507, 950.2303134461108, 965.8985806490358, 5131.7690703918415, 5285.762140703678, 5290.788368465295, 5300.628955973045, 5328.706921119298, 5586.720663966786, 5628.943710562924, 5631.577631677641, 5633.746481408347, 5673.574481913791, 5178.97410512945, 5305.283786688825, 5309.301023672465, 5312.31727977369, 5318.813841515528, 2970.702929707012, 2971.3314504236373, 2985.8656360463833, 2993.8054026488207, 3024.6370435547874, 5556.944430555724, 5810.4189581041555, 5838.737256823453, 5898.351181370046, 5901.970490147522, 5717.514011309086, 5832.795852145155, 5863.651360187181, 5868.706564671749, 5888.823335299948, 5838.941610583925, 5843.3864444233595, 5888.793892213837, 5923.141144533933, 5939.3763654816485, 5378.0, 5643.7742490299925, 5678.574106941914, 5697.601167918206, 5741.0, 5594.02104631696, 5596.272484576979, 5597.888042239214, 5607.467290607386, 5633.38032816398, 5751.396103409249, 5954.1244507979845, 5976.641401515923, 5996.160537524663, 6007.939920600738, 3901.785401802928, 3939.8030098495533, 3943.152222272225, 3944.9605503944595, 3968.305546529288, 5699.686517241592, 5735.971320143372, 5742.339630942328, 5763.5965482417505, 5798.913016304843, 5290.1800220965815, 5604.047311957059, 5614.915776263441, 5627.621232797991, 5631.239782629456, 5534.52956498686, 5552.722363881709, 5570.777168913198, 5574.498295153294, 5603.971980140236, 5292.655977361459, 5309.920351194813, 5520.91718624229, 5522.889542209053, 5533.3083364579425, 5526.088195447867, 5578.9163162553405, 5588.413216612197, 5605.673645437098, 5612.607117501736, 5399.4600539945695, 5424.267723857387, 5447.319085114361, 5459.645123066988, 5486.31421072366], "value": 4203.808746206916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.2967356827094, 728.876091064519, 791.5923299500754, 799.1089934722783, 810.4407958508626, 13535.52625658102, 13667.906567474603, 13738.107023043494, 13905.30473476326, 14023.649408764773, 13848.376823042961, 13886.305684715775, 14019.299035048258, 14020.64948376291, 14023.92988035061, 680.0343512212645, 787.7597332813503, 796.0407708711018, 828.9751307460785, 832.3923535818856, 803.2329125684986, 811.9553424561647, 812.4434762187891, 813.7518056992644, 814.2915663372873, 839.3956351426963, 841.1252297610478, 841.5834162089774, 841.7895526118471, 842.5534466732641, 707.4057791455176, 817.1215942861447, 821.1829229916212, 843.0852525010371, 843.7215718812777, 605.8091701114136, 605.9697015149225, 606.5966132521868, 608.333874407523, 609.3662590905453, 13537.323133843367, 13540.526081587195, 13545.322733863268, 13548.0, 13583.0, 13113.344332783417, 13361.53234636783, 13406.865931340757, 13460.192388456626, 13760.793588096187, 11823.940880295544, 11833.881661183364, 11924.284542927453, 11941.10441716866, 11976.640700778991, 4394.670399720034, 4445.977770111161, 4467.597916187558, 4506.369108324837, 4624.306354046887, 58577.0, 59212.0, 59241.703791481195, 60399.0, 61121.0, 11160.553577856957, 11241.83137252942, 11272.605458808903, 11310.886891131147, 11402.885971140182, 20498.692519612217, 20560.691589626167, 20569.48576285605, 20574.0, 20593.897030514752, 7661.770146895602, 7663.425243106789, 7827.569483678452, 7977.122516523178, 8251.2986396157, 4417.094495628388, 4420.0, 4479.790456576706, 4496.797644106023, 4583.72497650142, 3299.2741596848655, 3412.5563676721868, 3414.0, 3414.897553073412, 3415.3169366126376, 552.9668219906819, 555.5305766627193, 606.5693357715983, 635.4979566142788, 650.817771024114, 519.187471606934, 573.1088157914483, 656.967151642416, 659.8416380068749, 734.8309888725623, 8697.478151310816, 9037.502937338379, 9054.0, 9139.90860091404, 9159.90840091604, 628.8710814283153, 653.4837478392112, 686.5571706249541, 688.0985908459834, 708.5465302206592, 4354.629856462173, 4382.53983331752, 4401.317795741666, 4450.621697155713, 4485.439320084989, 69749.0, 70702.64648676723, 70893.0, 71346.0, 72286.63856680683, 45719.31421028687, 46742.0, 48624.5137548627, 62291.688541557, 62472.687636562434, 56615.150772738445, 57327.71336143293, 57683.0, 57902.42097579055, 58798.0, 8580.910396750607, 8677.1756683115, 8716.869246961427, 8733.606987685696, 8756.168164024408, 39421.408678870415, 39705.602943971346, 39742.80128599339, 39754.80122599369, 40129.197416050934, 44275.33586996262, 45166.09667806691, 46092.53907461017, 49111.50888491069, 53311.0, 10702.678919632424, 11017.669469915916, 11037.668869933916, 11058.170637202082, 11081.445927703744, 11450.599229026944, 11494.54021839117, 11551.249168804, 11561.710957226136, 11938.403079846146, 10900.291481053706, 10918.454077296263, 10978.121750259801, 11072.335659860435, 11249.831252531383, 10677.51951162184, 10775.946120269662, 10864.022237998619, 10937.945310273397, 11064.059554937921, 9968.750781230527, 10292.897071029194, 10341.84487232677, 10575.418351990715, 10612.204084693833, 9318.440893546409, 9423.148492742836, 9513.66702165421, 9610.471424071744, 9670.081342272473, 9260.30547708911, 9393.201577865684, 9408.341416100808, 9443.952780236055, 9468.384555003902], "value": 6602.106763836798, "unit": "score"}], "name": "dromaeo_css", "value": 7042.044650869869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 109.0, 111.0, 112.0, 110.0, 110.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 157.0, 207.0, 126.0, 152.0, 163.0, 131.0, 176.0, 126.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 161.0, 159.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 155.0, 75.0, 75.0, 76.0, 75.0, 137.0, 75.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 92.0, 93.0, 94.0, 125.0, 92.0, 92.0, 116.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 55.0, 57.0, 56.0, 56.0, 120.0, 57.0, 59.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 63.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 128.0, 119.0, 125.0, 132.0, 126.0, 120.0, 201.0, 122.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 171.0, 160.0, 164.0, 162.0, 165.0, 161.0, 158.0, 161.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 61.0, 62.0, 62.0, 60.0, 62.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1533.5, "alertThreshold": 2.0}]} 02:21:13 INFO - Return code: 0 02:21:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:21:13 ERROR - # TBPL SUCCESS # 02:21:13 INFO - Running post-action listener: _resource_record_post_action 02:21:13 INFO - ##### 02:21:13 INFO - ##### Finished run-tests step (success) 02:21:13 INFO - ##### 02:21:13 INFO - Running post-run listener: _resource_record_post_run 02:21:13 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536944640; Read time: 20; Write time: 412428 02:21:13 INFO - TinderboxPrint: CPU usage
13.1% 02:21:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 02:21:13 INFO - TinderboxPrint: I/O write bytes / time
536,944,640 / 412,428 02:21:13 INFO - TinderboxPrint: CPU idle
8,275.2 (86.9%) 02:21:13 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 02:21:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:21:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246886400; Read time: 0; Write time: 202052 02:21:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290058240; Read time: 20; Write time: 210376 02:21:13 INFO - Running post-run listener: _upload_blobber_files 02:21:13 INFO - Blob upload gear active. 02:21:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:13 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 02:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:21:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:16 INFO - (blobuploader) - INFO - Done attempting. 02:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:16 INFO - (blobuploader) - INFO - Done attempting. 02:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:21 INFO - (blobuploader) - INFO - Done attempting. 02:21:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:21 INFO - Return code: 0 02:21:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8cd4b712e8e7e9ec222393aa3b968f8c890b4b50b3aba359f57156c24f2fb02dc17f3392be3e025d1ea869d7582fbddba71a3dda17af56fecd5e8c3e06065e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79c97d12ce8a76b2dc19f9195a57857603deddc9eb0c8f76d07927374ca4887ca19c457638367cac2efb305742ea501adea12972c2c2e6cd32ed516fdf84b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/208891afb3961375ea9bc3dcf6cd754728bf3a6d0a724482fc5ab39d1372e41b236350d51d94b5e00145c75697f63d6a3422c9307c2357f4b5ab95c56c698642"} 02:21:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:21 INFO - Contents: 02:21:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8cd4b712e8e7e9ec222393aa3b968f8c890b4b50b3aba359f57156c24f2fb02dc17f3392be3e025d1ea869d7582fbddba71a3dda17af56fecd5e8c3e06065e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79c97d12ce8a76b2dc19f9195a57857603deddc9eb0c8f76d07927374ca4887ca19c457638367cac2efb305742ea501adea12972c2c2e6cd32ed516fdf84b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/208891afb3961375ea9bc3dcf6cd754728bf3a6d0a724482fc5ab39d1372e41b236350d51d94b5e00145c75697f63d6a3422c9307c2357f4b5ab95c56c698642"} 02:21:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:21 INFO - Copying logs to upload dir... 02:21:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.524331 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-20 02:21:20.687221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 02:21:20.690976) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8cd4b712e8e7e9ec222393aa3b968f8c890b4b50b3aba359f57156c24f2fb02dc17f3392be3e025d1ea869d7582fbddba71a3dda17af56fecd5e8c3e06065e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79c97d12ce8a76b2dc19f9195a57857603deddc9eb0c8f76d07927374ca4887ca19c457638367cac2efb305742ea501adea12972c2c2e6cd32ed516fdf84b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/208891afb3961375ea9bc3dcf6cd754728bf3a6d0a724482fc5ab39d1372e41b236350d51d94b5e00145c75697f63d6a3422c9307c2357f4b5ab95c56c698642"} build_url:https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/XtwNK2xGROyY20UCLnhRBg/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/sha512/b8cd4b712e8e7e9ec222393aa3b968f8c890b4b50b3aba359f57156c24f2fb02dc17f3392be3e025d1ea869d7582fbddba71a3dda17af56fecd5e8c3e06065e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79c97d12ce8a76b2dc19f9195a57857603deddc9eb0c8f76d07927374ca4887ca19c457638367cac2efb305742ea501adea12972c2c2e6cd32ed516fdf84b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/208891afb3961375ea9bc3dcf6cd754728bf3a6d0a724482fc5ab39d1372e41b236350d51d94b5e00145c75697f63d6a3422c9307c2357f4b5ab95c56c698642"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 02:21:20.716103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:21:20.716478) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463733464.729505-1699619782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:21:20.800555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 02:21:20.801344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 02:21:20.801744) ========= ========= Total master_lag: 0.17 =========