builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1459521942.36 results: success (0) buildid: 20160401065346 builduid: 3a3d373a6cdc42e495b2cb4675f6fceb revision: 02e0770a169643107e35465f690c46f160fca670 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:42.359057) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:42.359575) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:42.359894) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006413 basedir: '/builds/slave/test' ========= master_lag: 0.69 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.052063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.052367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.534950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.535279) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.589475) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.589886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.590355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:43.590734) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 07:45:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-01 07:45:44 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.817161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:44.421485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:44.421822) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020406 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:44.471799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 07:45:44.472227) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 02e0770a169643107e35465f690c46f160fca670 --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 02e0770a169643107e35465f690c46f160fca670 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 07:45:44,792 truncating revision to first 12 chars 2016-04-01 07:45:44,792 Setting DEBUG logging. 2016-04-01 07:45:44,792 attempt 1/10 2016-04-01 07:45:44,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/02e0770a1696?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 07:45:45,584 unpacking tar archive at: fx-team-02e0770a1696/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 07:45:45.602693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:45.603116) ========= echo 02e0770a169643107e35465f690c46f160fca670 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'02e0770a169643107e35465f690c46f160fca670'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02e0770a169643107e35465f690c46f160fca670 program finished with exit code 0 elapsedTime=0.004921 script_repo_revision: '02e0770a169643107e35465f690c46f160fca670' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:45.654161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:45.654527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 07:45:45.665305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-01 07:45:45.665731) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:45:46 INFO - MultiFileLogger online at 20160401 07:45:46 in /builds/slave/test 07:45:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:45:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:46 INFO - {'append_to_log': False, 07:45:46 INFO - 'base_work_dir': '/builds/slave/test', 07:45:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:45:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:46 INFO - 'branch': 'Fx-Team-Non-PGO', 07:45:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:46 INFO - 'config_files': ('talos/linux_config.py',), 07:45:46 INFO - 'default_actions': ('clobber', 07:45:46 INFO - 'read-buildbot-config', 07:45:46 INFO - 'download-and-extract', 07:45:46 INFO - 'populate-webroot', 07:45:46 INFO - 'create-virtualenv', 07:45:46 INFO - 'install', 07:45:46 INFO - 'run-tests'), 07:45:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:46 INFO - 'download_minidump_stackwalk': True, 07:45:46 INFO - 'download_symbols': 'ondemand', 07:45:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:46 INFO - 'installer_path': 'installer.exe', 07:45:46 INFO - 'log_level': 'info', 07:45:46 INFO - 'log_name': 'talos', 07:45:46 INFO - 'log_to_console': True, 07:45:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:45:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:45:46 INFO - 'opt_config_files': (), 07:45:46 INFO - 'pip_index': False, 07:45:46 INFO - 'sps_profile': False, 07:45:46 INFO - 'sps_profile_interval': 0, 07:45:46 INFO - 'suite': 'dromaeojs', 07:45:46 INFO - 'system_bits': '32', 07:45:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:46 INFO - 'title': 'talos-linux64-ix-013', 07:45:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:46 INFO - 'use_talos_json': True, 07:45:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:46 INFO - 'work_dir': 'build'} 07:45:46 INFO - ##### 07:45:46 INFO - ##### Running clobber step. 07:45:46 INFO - ##### 07:45:46 INFO - Running pre-action listener: _resource_record_pre_action 07:45:46 INFO - Running main action method: clobber 07:45:46 INFO - rmtree: /builds/slave/test/build 07:45:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:47 INFO - Running post-action listener: _resource_record_post_action 07:45:47 INFO - ##### 07:45:47 INFO - ##### Running read-buildbot-config step. 07:45:47 INFO - ##### 07:45:47 INFO - Running pre-action listener: _resource_record_pre_action 07:45:47 INFO - Running main action method: read_buildbot_config 07:45:47 INFO - Using buildbot properties: 07:45:47 INFO - { 07:45:47 INFO - "project": "", 07:45:47 INFO - "product": "firefox", 07:45:47 INFO - "script_repo_revision": "production", 07:45:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:45:47 INFO - "repository": "", 07:45:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:45:47 INFO - "buildid": "20160401065346", 07:45:47 INFO - "pgo_build": "False", 07:45:47 INFO - "basedir": "/builds/slave/test", 07:45:47 INFO - "buildnumber": 1589, 07:45:47 INFO - "slavename": "talos-linux64-ix-013", 07:45:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:45:47 INFO - "platform": "ubuntu64_hw", 07:45:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:45:47 INFO - "branch": "fx-team", 07:45:47 INFO - "repo_path": "integration/fx-team", 07:45:47 INFO - "revision": "02e0770a169643107e35465f690c46f160fca670", 07:45:47 INFO - "stage_platform": "linux64", 07:45:47 INFO - "builduid": "3a3d373a6cdc42e495b2cb4675f6fceb", 07:45:47 INFO - "slavebuilddir": "test" 07:45:47 INFO - } 07:45:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:45:47 INFO - Running post-action listener: _resource_record_post_action 07:45:47 INFO - ##### 07:45:47 INFO - ##### Running download-and-extract step. 07:45:47 INFO - ##### 07:45:47 INFO - Running pre-action listener: _resource_record_pre_action 07:45:47 INFO - Running main action method: download_and_extract 07:45:47 INFO - mkdir: /builds/slave/test/build/tests 07:45:47 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')]} 07:45:47 INFO - https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:45:49 INFO - Downloaded 1361 bytes. 07:45:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:45:49 INFO - Using the following test package requirements: 07:45:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:45:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:45:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:45:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'jsshell-linux-x86_64.zip'], 07:45:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:45:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:45:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:45:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:45:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:45:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:45:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:49 INFO - https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:45:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:45:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:45:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:45:59 INFO - Downloaded 22112056 bytes. 07:45:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:45:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:46:01 INFO - Return code: 0 07:46:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:46: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')]} 07:46:01 INFO - https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:46:14 INFO - Downloaded 22112056 bytes. 07:46:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:46:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:46:15 INFO - Return code: 0 07:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:15 INFO - https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:46:17 INFO - Downloaded 10847534 bytes. 07:46:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:46:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:46:18 INFO - Return code: 0 07:46:18 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')]} 07:46:18 INFO - https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:46:20 INFO - Downloaded 54219101 bytes. 07:46:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:46:20 INFO - mkdir: /builds/slave/test/properties 07:46:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:20 INFO - Contents: 07:46:20 INFO - build_url:https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:46:21 INFO - Running post-action listener: _resource_record_post_action 07:46:21 INFO - Running post-action listener: set_extra_try_arguments 07:46:21 INFO - ##### 07:46:21 INFO - ##### Running populate-webroot step. 07:46:21 INFO - ##### 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: populate_webroot 07:46:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:21 INFO - '--tppagecycles', 07:46:21 INFO - '7'], 07:46:21 INFO - 'tests': ['tsvgm']}}, 07:46:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:46:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:46:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'tests': ['damp', 'tps']}, 07:46:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['damp', 'tps']}, 07:46:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:46:21 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['dromaeo_dom']}, 07:46:21 INFO - 'other': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other_l64': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other_nol64': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'svgr': {'tests': ['tsvgx', 07:46:21 INFO - 'tsvgr_opacity', 07:46:21 INFO - 'tart', 07:46:21 INFO - 'tscrollx', 07:46:21 INFO - 'cart']}, 07:46:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['tsvgx', 07:46:21 INFO - 'tsvgr_opacity', 07:46:21 INFO - 'tart', 07:46:21 INFO - 'tscrollx', 07:46:21 INFO - 'cart']}, 07:46:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'tests': ['tp5o']}, 07:46:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'talos_options': ['--e10s'], 07:46:21 INFO - 'tests': ['tp5o']}, 07:46:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'talos_options': ['--xperf_path', 07:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:21 INFO - 'tests': ['tp5n']}, 07:46:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:21 INFO - 'talos_options': ['--e10s', 07:46:21 INFO - '--xperf_path', 07:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:21 INFO - 'tests': ['tp5n']}}, 07:46:21 INFO - 'talos.zip': {'path': '', 07:46:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:21 INFO - Running post-action listener: _resource_record_post_action 07:46:21 INFO - ##### 07:46:21 INFO - ##### Running create-virtualenv step. 07:46:21 INFO - ##### 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: create_virtualenv 07:46:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:21 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 07:46:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:22 INFO - Using real prefix '/usr' 07:46:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:24 INFO - Installing pip.................done. 07:46:24 INFO - Return code: 0 07:46:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:24 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')]} 07:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:24 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')]} 07:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:24 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 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:24 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 07:46:24 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 07:46:24 INFO - Using env: {'DISPLAY': ':0', 07:46:24 INFO - 'HOME': '/home/cltbld', 07:46:24 INFO - 'LANG': 'en_US.UTF-8', 07:46:24 INFO - 'LANGUAGE': 'en_US:en', 07:46:24 INFO - 'LOGNAME': 'cltbld', 07:46:24 INFO - 'MAIL': '/var/mail/cltbld', 07:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:24 INFO - 'MOZ_NO_REMOTE': '1', 07:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:24 INFO - 'NO_EM_RESTART': '1', 07:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:24 INFO - 'PWD': '/builds/slave/test', 07:46:24 INFO - 'SHELL': '/bin/bash', 07:46:24 INFO - 'SHLVL': '1', 07:46:24 INFO - 'TERM': 'linux', 07:46:24 INFO - 'TMOUT': '86400', 07:46:24 INFO - 'USER': 'cltbld', 07:46:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:24 INFO - '_': '/tools/buildbot/bin/python'} 07:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:24 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 07:46:24 INFO - Cleaning up... 07:46:24 INFO - Return code: 0 07:46:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:46:24 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')]} 07:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:24 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')]} 07:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:24 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:24 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>=0.7.1'] in /builds/slave/test/build 07:46:24 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>=0.7.1 07:46:24 INFO - Using env: {'DISPLAY': ':0', 07:46:24 INFO - 'HOME': '/home/cltbld', 07:46:24 INFO - 'LANG': 'en_US.UTF-8', 07:46:24 INFO - 'LANGUAGE': 'en_US:en', 07:46:24 INFO - 'LOGNAME': 'cltbld', 07:46:24 INFO - 'MAIL': '/var/mail/cltbld', 07:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:24 INFO - 'MOZ_NO_REMOTE': '1', 07:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:24 INFO - 'NO_EM_RESTART': '1', 07:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:24 INFO - 'PWD': '/builds/slave/test', 07:46:24 INFO - 'SHELL': '/bin/bash', 07:46:24 INFO - 'SHLVL': '1', 07:46:24 INFO - 'TERM': 'linux', 07:46:24 INFO - 'TMOUT': '86400', 07:46:24 INFO - 'USER': 'cltbld', 07:46:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:24 INFO - '_': '/tools/buildbot/bin/python'} 07:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:24 INFO - Downloading/unpacking psutil>=0.7.1 07:46:24 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 07:46:24 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 07:46:24 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 07:46:24 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 07:46:24 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 07:46:24 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 07:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:29 INFO - Installing collected packages: psutil 07:46:29 INFO - Running setup.py install for psutil 07:46:30 INFO - building 'psutil._psutil_linux' extension 07:46:30 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 07:46:30 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 07:46:30 INFO - building 'psutil._psutil_posix' extension 07:46:30 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 07:46:30 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 07:46:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:30 INFO - Successfully installed psutil 07:46:30 INFO - Cleaning up... 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:30 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.0.0'] in /builds/slave/test/build 07:46:30 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.0.0 07:46:30 INFO - Using env: {'DISPLAY': ':0', 07:46:30 INFO - 'HOME': '/home/cltbld', 07:46:30 INFO - 'LANG': 'en_US.UTF-8', 07:46:30 INFO - 'LANGUAGE': 'en_US:en', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MAIL': '/var/mail/cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SHLVL': '1', 07:46:30 INFO - 'TERM': 'linux', 07:46:30 INFO - 'TMOUT': '86400', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - '_': '/tools/buildbot/bin/python'} 07:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:46:30 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 07:46:30 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 07:46:30 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 07:46:30 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 07:46:30 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 07:46:30 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 07:46:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:46:33 INFO - Installing collected packages: mozsystemmonitor 07:46:33 INFO - Running setup.py install for mozsystemmonitor 07:46:33 INFO - Successfully installed mozsystemmonitor 07:46:33 INFO - Cleaning up... 07:46:33 INFO - Return code: 0 07:46:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:33 INFO - Using env: {'DISPLAY': ':0', 07:46:33 INFO - 'HOME': '/home/cltbld', 07:46:33 INFO - 'LANG': 'en_US.UTF-8', 07:46:33 INFO - 'LANGUAGE': 'en_US:en', 07:46:33 INFO - 'LOGNAME': 'cltbld', 07:46:33 INFO - 'MAIL': '/var/mail/cltbld', 07:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:33 INFO - 'MOZ_NO_REMOTE': '1', 07:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:33 INFO - 'NO_EM_RESTART': '1', 07:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:33 INFO - 'PWD': '/builds/slave/test', 07:46:33 INFO - 'SHELL': '/bin/bash', 07:46:33 INFO - 'SHLVL': '1', 07:46:33 INFO - 'TERM': 'linux', 07:46:33 INFO - 'TMOUT': '86400', 07:46:33 INFO - 'USER': 'cltbld', 07:46:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:33 INFO - '_': '/tools/buildbot/bin/python'} 07:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:33 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 07:46:33 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 07:46:33 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 07:46:33 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 07:46:33 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 07:46:33 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 07:46:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 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 07:46:37 INFO - Downloading docopt-0.6.1.tar.gz 07:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:37 INFO - Running setup.py install for blobuploader 07:46:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:37 INFO - Running setup.py install for requests 07:46:38 INFO - Running setup.py install for docopt 07:46:38 INFO - Successfully installed blobuploader requests docopt 07:46:38 INFO - Cleaning up... 07:46:38 INFO - Return code: 0 07:46:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:38 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 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:38 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 07:46:38 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 07:46:38 INFO - Using env: {'DISPLAY': ':0', 07:46:38 INFO - 'HOME': '/home/cltbld', 07:46:38 INFO - 'LANG': 'en_US.UTF-8', 07:46:38 INFO - 'LANGUAGE': 'en_US:en', 07:46:38 INFO - 'LOGNAME': 'cltbld', 07:46:38 INFO - 'MAIL': '/var/mail/cltbld', 07:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:38 INFO - 'MOZ_NO_REMOTE': '1', 07:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:38 INFO - 'NO_EM_RESTART': '1', 07:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:38 INFO - 'PWD': '/builds/slave/test', 07:46:38 INFO - 'SHELL': '/bin/bash', 07:46:38 INFO - 'SHLVL': '1', 07:46:38 INFO - 'TERM': 'linux', 07:46:38 INFO - 'TMOUT': '86400', 07:46:38 INFO - 'USER': 'cltbld', 07:46:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:38 INFO - '_': '/tools/buildbot/bin/python'} 07:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:38 INFO - Running setup.py (path:/tmp/pip-OIGIMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:38 INFO - Running setup.py (path:/tmp/pip-K8cCDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:38 INFO - Running setup.py (path:/tmp/pip-oL4NIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:38 INFO - Running setup.py (path:/tmp/pip-kaimiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:38 INFO - Running setup.py (path:/tmp/pip-EqhYv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:38 INFO - Running setup.py (path:/tmp/pip-9kashc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:38 INFO - Running setup.py (path:/tmp/pip-vI5iX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:39 INFO - Running setup.py (path:/tmp/pip-UHDggF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:39 INFO - Running setup.py (path:/tmp/pip-vMIQWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:39 INFO - Running setup.py (path:/tmp/pip-1IjOyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:39 INFO - Running setup.py (path:/tmp/pip-u7oiEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:39 INFO - Running setup.py (path:/tmp/pip-4JjzNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:39 INFO - Running setup.py (path:/tmp/pip-Ge8N_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:39 INFO - Running setup.py (path:/tmp/pip-nKLkhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:39 INFO - Running setup.py (path:/tmp/pip-lN4ON3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:39 INFO - Running setup.py (path:/tmp/pip-P3cqVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:39 INFO - Running setup.py (path:/tmp/pip-4kFreh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:39 INFO - Running setup.py install for manifestparser 07:46:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Running setup.py install for mozcrash 07:46:39 INFO - Running setup.py install for mozdebug 07:46:40 INFO - Running setup.py install for mozdevice 07:46:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for mozfile 07:46:40 INFO - Running setup.py install for mozhttpd 07:46:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for mozinfo 07:46:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for mozInstall 07:46:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for mozleak 07:46:40 INFO - Running setup.py install for mozlog 07:46:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for moznetwork 07:46:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Running setup.py install for mozprocess 07:46:41 INFO - Running setup.py install for mozprofile 07:46:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:41 INFO - Running setup.py install for mozrunner 07:46:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:41 INFO - Running setup.py install for mozscreenshot 07:46:41 INFO - Running setup.py install for moztest 07:46:41 INFO - Running setup.py install for mozversion 07:46:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:41 INFO - Cleaning up... 07:46:41 INFO - Return code: 0 07:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 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 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:41 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 07:46:41 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 07:46:41 INFO - Using env: {'DISPLAY': ':0', 07:46:41 INFO - 'HOME': '/home/cltbld', 07:46:41 INFO - 'LANG': 'en_US.UTF-8', 07:46:41 INFO - 'LANGUAGE': 'en_US:en', 07:46:41 INFO - 'LOGNAME': 'cltbld', 07:46:41 INFO - 'MAIL': '/var/mail/cltbld', 07:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:41 INFO - 'MOZ_NO_REMOTE': '1', 07:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:41 INFO - 'NO_EM_RESTART': '1', 07:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:41 INFO - 'PWD': '/builds/slave/test', 07:46:41 INFO - 'SHELL': '/bin/bash', 07:46:41 INFO - 'SHLVL': '1', 07:46:41 INFO - 'TERM': 'linux', 07:46:41 INFO - 'TMOUT': '86400', 07:46:41 INFO - 'USER': 'cltbld', 07:46:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:41 INFO - '_': '/tools/buildbot/bin/python'} 07:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:41 INFO - Running setup.py (path:/tmp/pip-umyEDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:41 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)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:41 INFO - Running setup.py (path:/tmp/pip-ROyOtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:41 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)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:41 INFO - Running setup.py (path:/tmp/pip-JBsKoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:41 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)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:42 INFO - Running setup.py (path:/tmp/pip-20_2HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:42 INFO - Running setup.py (path:/tmp/pip-dNNRAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:42 INFO - Running setup.py (path:/tmp/pip-6YZLDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:42 INFO - Running setup.py (path:/tmp/pip-9lDBsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:42 INFO - Running setup.py (path:/tmp/pip-KKIT4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:42 INFO - Running setup.py (path:/tmp/pip-eshOkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:42 INFO - Running setup.py (path:/tmp/pip-uHesuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:42 INFO - Running setup.py (path:/tmp/pip-BLgrl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:42 INFO - Running setup.py (path:/tmp/pip-dt1IO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:42 INFO - Running setup.py (path:/tmp/pip-P91XIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:42 INFO - Running setup.py (path:/tmp/pip-GhK5pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:42 INFO - Running setup.py (path:/tmp/pip-GaxYH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:42 INFO - Running setup.py (path:/tmp/pip-Pa6uQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:42 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)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:42 INFO - Running setup.py (path:/tmp/pip-_kkw4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - Downloading blessings-1.6.tar.gz 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:45 INFO - Installing collected packages: blessings 07:46:45 INFO - Running setup.py install for blessings 07:46:45 INFO - Successfully installed blessings 07:46:45 INFO - Cleaning up... 07:46:45 INFO - Return code: 0 07:46:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:45 INFO - Reading from file tmpfile_stdout 07:46:45 INFO - Current package versions: 07:46:45 INFO - argparse == 1.2.1 07:46:45 INFO - blessings == 1.6 07:46:45 INFO - blobuploader == 1.2.4 07:46:45 INFO - docopt == 0.6.1 07:46:45 INFO - manifestparser == 1.1 07:46:45 INFO - mozInstall == 1.12 07:46:45 INFO - mozcrash == 0.17 07:46:45 INFO - mozdebug == 0.1 07:46:45 INFO - mozdevice == 0.48 07:46:45 INFO - mozfile == 1.2 07:46:45 INFO - mozhttpd == 0.7 07:46:45 INFO - mozinfo == 0.9 07:46:45 INFO - mozleak == 0.1 07:46:45 INFO - mozlog == 3.1 07:46:45 INFO - moznetwork == 0.27 07:46:45 INFO - mozprocess == 0.22 07:46:45 INFO - mozprofile == 0.28 07:46:45 INFO - mozrunner == 6.11 07:46:45 INFO - mozscreenshot == 0.1 07:46:45 INFO - mozsystemmonitor == 0.0 07:46:45 INFO - moztest == 0.7 07:46:45 INFO - mozversion == 1.4 07:46:45 INFO - psutil == 3.1.1 07:46:45 INFO - requests == 1.2.3 07:46:45 INFO - wsgiref == 0.1.2 07:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 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 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:45 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 07:46:45 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 07:46:45 INFO - Using env: {'DISPLAY': ':0', 07:46:45 INFO - 'HOME': '/home/cltbld', 07:46:45 INFO - 'LANG': 'en_US.UTF-8', 07:46:45 INFO - 'LANGUAGE': 'en_US:en', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MAIL': '/var/mail/cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SHLVL': '1', 07:46:45 INFO - 'TERM': 'linux', 07:46:45 INFO - 'TMOUT': '86400', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - '_': '/tools/buildbot/bin/python'} 07:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 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)) 07:46:45 INFO - Cleaning up... 07:46:45 INFO - Return code: 0 07:46:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:46:45 INFO - Using env: {'DISPLAY': ':0', 07:46:45 INFO - 'HOME': '/home/cltbld', 07:46:45 INFO - 'LANG': 'en_US.UTF-8', 07:46:45 INFO - 'LANGUAGE': 'en_US:en', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MAIL': '/var/mail/cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SHLVL': '1', 07:46:45 INFO - 'TERM': 'linux', 07:46:45 INFO - 'TMOUT': '86400', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - '_': '/tools/buildbot/bin/python'} 07:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:45 INFO - Downloading/unpacking jsonschema 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:48 INFO - Downloading/unpacking functools32 (from jsonschema) 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:48 INFO - warning: no files found matching '*.txt' 07:46:48 INFO - no previously-included directories found matching 'build' 07:46:48 INFO - no previously-included directories found matching 'dist' 07:46:48 INFO - no previously-included directories found matching '.git*' 07:46:48 INFO - Installing collected packages: jsonschema, functools32 07:46:48 INFO - Running setup.py install for functools32 07:46:48 INFO - warning: no files found matching '*.txt' 07:46:48 INFO - no previously-included directories found matching 'build' 07:46:48 INFO - no previously-included directories found matching 'dist' 07:46:48 INFO - no previously-included directories found matching '.git*' 07:46:48 INFO - Successfully installed jsonschema functools32 07:46:48 INFO - Cleaning up... 07:46:48 INFO - Return code: 0 07:46:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb700cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', '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 07:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:46:48 INFO - Using env: {'DISPLAY': ':0', 07:46:48 INFO - 'HOME': '/home/cltbld', 07:46:48 INFO - 'LANG': 'en_US.UTF-8', 07:46:48 INFO - 'LANGUAGE': 'en_US:en', 07:46:48 INFO - 'LOGNAME': 'cltbld', 07:46:48 INFO - 'MAIL': '/var/mail/cltbld', 07:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:48 INFO - 'MOZ_NO_REMOTE': '1', 07:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:48 INFO - 'NO_EM_RESTART': '1', 07:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:48 INFO - 'PWD': '/builds/slave/test', 07:46:48 INFO - 'SHELL': '/bin/bash', 07:46:48 INFO - 'SHLVL': '1', 07:46:48 INFO - 'TERM': 'linux', 07:46:48 INFO - 'TMOUT': '86400', 07:46:48 INFO - 'USER': 'cltbld', 07:46:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:48 INFO - '_': '/tools/buildbot/bin/python'} 07:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:48 INFO - Downloading/unpacking flake8 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:46:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:46:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:51 INFO - no previously-included directories found matching 'docs/_build' 07:46:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:46:51 INFO - Running setup.py install for pep8 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:51 INFO - no previously-included directories found matching 'docs/_build' 07:46:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Running post-action listener: _resource_record_post_action 07:46:51 INFO - Running post-action listener: _start_resource_monitoring 07:46:51 INFO - Starting resource monitoring. 07:46:51 INFO - ##### 07:46:51 INFO - ##### Running install step. 07:46:51 INFO - ##### 07:46:51 INFO - Running pre-action listener: _resource_record_pre_action 07:46:51 INFO - Running main action method: install 07:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:51 INFO - Reading from file tmpfile_stdout 07:46:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:46:51 INFO - Reading from file tmpfile_stdout 07:46:51 INFO - Output received: 07:46:51 INFO - Usage: mozinstall [options] installer 07:46:51 INFO - Options: 07:46:51 INFO - -h, --help show this help message and exit 07:46:51 INFO - -d DEST, --destination=DEST 07:46:51 INFO - Directory to install application into. [default: 07:46:51 INFO - "/builds/slave/test"] 07:46:51 INFO - --app=APP Application being installed. [default: firefox] 07:46:51 INFO - mkdir: /builds/slave/test/build/application 07:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:47:07 INFO - Reading from file tmpfile_stdout 07:47:07 INFO - Output received: 07:47:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:07 INFO - Running post-action listener: _resource_record_post_action 07:47:07 INFO - ##### 07:47:07 INFO - ##### Running run-tests step. 07:47:07 INFO - ##### 07:47:07 INFO - Running pre-action listener: _resource_record_pre_action 07:47:07 INFO - Running main action method: run_tests 07:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:07 INFO - Python 2.7.3 07:47:07 INFO - Return code: 0 07:47:07 INFO - grabbing minidump binary from tooltool 07:47:07 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')]} 07:47:07 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4410>, '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 0x1de5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:07 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 07:47:07 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 07:47:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:07 INFO - Return code: 0 07:47:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:47:08 INFO - Return code: 0 07:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:08 INFO - Using env: {'DISPLAY': ':0', 07:47:08 INFO - 'HOME': '/home/cltbld', 07:47:08 INFO - 'LANG': 'en_US.UTF-8', 07:47:08 INFO - 'LANGUAGE': 'en_US:en', 07:47:08 INFO - 'LOGNAME': 'cltbld', 07:47:08 INFO - 'MAIL': '/var/mail/cltbld', 07:47:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:08 INFO - 'MOZ_NO_REMOTE': '1', 07:47:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:08 INFO - 'NO_EM_RESTART': '1', 07:47:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:08 INFO - 'PWD': '/builds/slave/test', 07:47:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:08 INFO - 'SHELL': '/bin/bash', 07:47:08 INFO - 'SHLVL': '1', 07:47:08 INFO - 'TERM': 'linux', 07:47:08 INFO - 'TMOUT': '86400', 07:47:08 INFO - 'USER': 'cltbld', 07:47:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989', 07:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:08 INFO - '_': '/tools/buildbot/bin/python'} 07:47:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:08 INFO - mozversion application_buildid: 20160401065346 07:47:08 INFO - mozversion application_changeset: 02e0770a169643107e35465f690c46f160fca670 07:47:08 INFO - mozversion application_display_name: Nightly 07:47:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:08 INFO - mozversion application_name: Firefox 07:47:08 INFO - mozversion application_remotingname: firefox 07:47:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:47:08 INFO - mozversion application_vendor: Mozilla 07:47:08 INFO - mozversion application_version: 48.0a1 07:47:08 INFO - mozversion platform_buildid: 20160401065346 07:47:08 INFO - mozversion platform_changeset: 02e0770a169643107e35465f690c46f160fca670 07:47:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:47:08 INFO - mozversion platform_version: 48.0a1 07:47:08 INFO - using testdate: 1459522028 07:47:08 INFO - actual date: 1459522028 07:47:08 INFO - starting webserver on 'localhost:52517' 07:47:08 INFO - SUITE-START | Running 2 tests 07:47:08 INFO - TEST-START | dromaeo_css 07:47:08 INFO - operating with platform_type : linux_ 07:47:08 INFO - Initialising browser for dromaeo_css test... 07:47:08 INFO - TEST-INFO | started process 26354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOd86gI/profile http://localhost:52517/getInfo.html) 07:47:13 INFO - PROCESS | 26354 | __metrics Screen width/height:1600/1200 07:47:13 INFO - PROCESS | 26354 | colorDepth:24 07:47:13 INFO - PROCESS | 26354 | Browser inner width/height: 1024/697 07:47:13 INFO - PROCESS | 26354 | __metrics 07:47:14 ERROR - PROCESS | 26354 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:47:15 INFO - TEST-INFO | 26354: exit 0 07:47:15 INFO - Browser initialized. 07:47:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:15 INFO - TEST-INFO | started process 26435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOd86gI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:27 INFO - PROCESS | 26435 | RSS: Main: 154341376 07:47:27 INFO - PROCESS | 26435 | 07:48:17 INFO - PROCESS | 26435 | 1459522097827 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] 07:50:30 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52517/tests/dromaeo/cssquery-ext.html) 07:50:32 INFO - PROCESS | 26435 | RSS: Main: 329580544 07:50:32 INFO - PROCESS | 26435 | 07:53:34 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-ext.html (next: http://localhost:52517/tests/dromaeo/cssquery-jquery.html) 07:53:35 INFO - PROCESS | 26435 | RSS: Main: 242466816 07:53:35 INFO - PROCESS | 26435 | 07:56:37 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52517/tests/dromaeo/cssquery-mootools.html) 07:56:37 INFO - PROCESS | 26435 | RSS: Main: 240668672 07:56:37 INFO - PROCESS | 26435 | 07:59:39 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52517/tests/dromaeo/cssquery-prototype.html) 07:59:40 INFO - PROCESS | 26435 | RSS: Main: 223670272 07:59:40 INFO - PROCESS | 26435 | 08:02:43 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52517/tests/dromaeo/cssquery-yui.html) 08:02:43 INFO - PROCESS | 26435 | RSS: Main: 200671232 08:02:43 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | Cycle 1(1): loaded http://localhost:52517/tests/dromaeo/cssquery-yui.html (next: http://localhost:52517/tests/dromaeo/cssquery-dojo.html) 08:05:46 INFO - PROCESS | 26435 | RSS: Main: 243277824 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | __start_tp_report 08:05:46 INFO - PROCESS | 26435 | _x_x_mozilla_page_load 08:05:46 INFO - PROCESS | 26435 | _x_x_mozilla_page_load_details 08:05:46 INFO - PROCESS | 26435 | |i|pagename|runs| 08:05:46 INFO - PROCESS | 26435 | |0;dojo.html;2648.6821581410236;2714.8506832124226;2717.592361145828;2717.945641087177;2759.7378249066333;4562.475315338737;4658.60401865841;4660.603848672863;4668.276417155342;4690.273007683814;4677.649176311773;4686.437627484698;4723.055388922221;4774;4782.330473733671;4281.978590107045;4303.074838909642;4320;4373.584509471595;4475.0378668586245;4385.780710964471;4424.181526417623;4437.778111094449;4451.5103338632725;4472.150291444631;4248.766317852517;4268.722533035343;4314.697971142022;4320.416743739586;4366.8253269869165;4304.139172165579;4309.741415515079;4329.502107257674;4351.369051487548;4366.039471316337;4289.721168124093;4290.914181716348;4301.698881078294;4308.9138217235795;4333.2200203963275;4451.465824101097;4492.865214043584;4498.707584007029;4579;4602.6087782538525;5022.67352622082;5024.648274620778;5025.497450254982;5026.220935754964;5034.622403319766;5044.949550504484;5053.8231161909525;5064.11378008847;5096.133657278272;5105.310783044279;4602.88492787683;4639.721616702941;4702.294655801623;4718.551737584924;4724.858254252378;5081.2632168335385;5082.2122571001555;5090.516400941905;5105.33630628016;5140.331756871583;4878.121938051185;4885.169521181408;4885.682430641997;4888.535589119028;4930.827421040246;4942.505749425029;4998.075356059141;5024.522670346311;5091.159958606862;5094.61790365724;4904.337914381585;4918.213085906238;4936.358273424432;4939.506049395031;4994.2508623706735;4878.268259760993;4914.385701787277;4916.72957987307;4924.3105965164905;4954.529319714621;4243.42713733642;4245.1085272093205;4304.7632380218765;4309.978450107729;4316.633086187647;3663.084228942764;3696.9815150924073;3698.5746639136305;3702.3891057975134;3737.9065523362133;4328.7402755834755;4329.393884856123;4329.935050974238;4352.760598167068;4377.321515165155;4894.608431325485;5039.244113382949;5047.924281135786;5130.615203859726;5133.204353325241;4298.742075475419;4302.225599392077;4305.763183024964;4310.051788606502;4353.673474489426;4522.208613492626;4527.660425468103;4529.456465224194;4532.773361331986;4563.041761230179;4624.12141693084;4754.334393184888;4780.49804770508;4830.734309613005;4843.660943733905;5000.174971129868;5001.949980500149;5021.347224860745;5029.1953287473825;5074.264231686311;4681.274402467623;4754.405699287589;4761.809527618995;4763.618910487084;4808.326834243278;4921.581665558468;4948.752562371939;4975;4982.153033984304;4984.925226121683;4901.117798796251;4909.214525675875;4912.140375434356;4912.82805101834;4917.803287868588;4750.311204875343;4795;4796.472388037383;4816.325714400057;4843.2250839865455;4797.088553174885;4800.927986080142;4821.011692602938;4826.710397376029;4828.2998965150555;4705.411823522059;4740.288956656529;4748.9314904146295;4751.904961900674;4774.618030557616;4857.101436234308;4871.732054737024;4876.390451193601;4876.853694389174;4917.139500587311;4800.207965685762;4825.30033145199;4835.830745923876;4869.123557759637;4873.439554451284 08:05:46 INFO - PROCESS | 26435 | |1;ext.html;533.5331584863247;553.3028384235866;554.6006875049964;568.6929058308514;569.4078158714937;27572;34696.306073878506;35159.82420087899;35288.117797055085;35410.64589354112;39910.401343979865;40738.38892416616;40761.18477630446;40772.18455630893;40833.387499187535;7810.609469526516;8009.199080092002;8013.799655008613;8014.198580141969;8022.277994980451;7829.138794732575;7941.761747147595;7947.443678942476;7947.602619869012;7974.1627129151475;7909.169537198598;7949.602519874012;7994.120646728855;7994.2805147537;7997.200279971986;7871.567063811488;7906;7916;7917.524948503051;7944.682212711456;7873.409494287951;7991.081025682063;8001.839963200703;8004.519728816232;8012.278894899487;38729;38982.415263771065;39117.60882391168;39171.216575668324;39252.21495570073;2840;2914.082906306687;2916.28551005003;2995.7902946793733;3157.2896098377682;28629.421322334707;29052;29146;29286.560701589493;29918.85040574805;3142.0887942496647;3142.71715545602;3145.7011583899493;3173.1273899677544;3246.8863589774483;232724;235078.8246058776;235091;236029;237890;41733;42567;54945.45054549483;55250.72374638182;55417;40564.79717601393;40567.39148912769;40623.1875362497;40698;40720.592794072276;11913.10651701126;12057.0957178212;12060.819087713691;12064.336461494526;12069.818952715716;9264.212541934012;9312.8603070954;9322.487263200454;9323.487208203478;9323.90676093244;13874.930625347011;14321.212333321559;14457.421703131968;14473.493427729978;14488.203148826706;5761.337446193657;5864.560157988168;5907.4683278505145;5973.701314934236;6005.399460054047;880.9207171354609;893.620211410148;896.8385690575628;913.7213149989184;1001.3741411617739;25496;26330.73669263321;26838.86580567085;26842.194734158005;26864.32839179036;922.5479515037717;959.9424034557949;982.9164521015794;987.09680642213;1031.4120951057976;13732.45070197181;14139.798117160157;14151.433942642385;14177.929110354382;14190.645233869236;276561;283452;284263;284875;285371;46826.76586617045;47669;47775.283370749465;47802.04395912132;47854.521454785005;1137.670075678044;1210.0924306769923;1214.40494157862;1247.9376031198585;1252.1673087396962;24360.953337229836;24683.753162468147;24722.13472528453;24822.627660584745;26307.605385918843;37855.62144378521;38123.80938095292;38367.42448863213;38381.424278635284;38418.42372364361;193133;193889;193949;194166;237084;30962;31185.53221701722;31256.531152033192;31271.84364078165;31471.68528314779;34682;35613.64386356103;36054.8197259012;36128.45807312945;36196.09509762277;30265.546016809327;30979.225519362197;37181.44227836639;40085.39871901865;40999.59000409958;33526.83236583802;33678.49482257817;33718.831405842815;33910.66089339174;33974.15064623305;33766.15584610404;33928.66071339255;34091.97724068282;34143;34440.13899652529;30740.231494212825;30986.69013309928;30993.070207893797;31105;31163.532547012266;23773.64339534874;24275.95312107464;24296.75703242945;24678.25965221046;24702.382440438414 08:05:46 INFO - PROCESS | 26435 | |2;jquery.html;346.18818869750424;347.37472549411063;360.93322735293975;360.9711223102152;361.95475565554307;15336.23318834058;15900.92049539752;16053.919730401332;16657.583560410996;16726.163691815393;14972.625684357896;15147.6970460591;15171.620709482268;15189;15314;4497.347884556737;4585.2892801615635;4653.976730116345;4655.580997710205;4666.323383109447;4945.802167913297;4949.7030178189425;4992.425871024824;4994.825181118662;4995.675281106716;5004.074246264435;5005.174146265862;5010.6993580385115;5010.799568017275;5017;4999.60003199745;6129.509639228851;6402.359764023607;6411.743530258831;6416.615003099829;6117.816465506042;6161.045038019114;6165.660888651122;6169.969150154266;6194.132821404962;21167.68248476274;21412.357629271148;22011.559768804695;22016.229431969965;22081.668774968388;1965.351434026782;1979.2182088075274;2010.8190262876412;2042.6323261812868;2070.130545171032;13272.469101235938;13782.448702051906;13823.654408639764;14437.855621443756;14607.78088328676;1845.5293900055399;1896.2983696032418;1911.5890083631946;1982.6530357187435;2040.6428874946973;67093.66453167703;68811;70590.64704676444;70848.2915170852;72064.63967680128;14689.988552346744;14892.851071489364;14966.850331496764;15004.24978751058;15397.9230103851;25191.49617007686;25487.36281592938;25495.23514294574;25496.107636232642;25580.23259302224;7659.4255430841795;7824.413169012347;7934.166912474223;7960.800979975431;7986.560739159286;6388.648624325614;6416.4225219729515;6470.09418681385;6489.740410383626;6548.083268342436;7458.440616953751;7462.44031697614;7509.9249007509225;7547.433942454338;7660.310572048543;2942.3232656489126;3025.3041800386036;3050.145959131447;3082.568440418343;3188.5217217417107;809.3929552835374;833.5748768128299;880.2781718990367;935;1000.7798284377425;15735;15752.921235393978;15803.20983950798;16027.278772455267;16101;859.0593300336246;859.4284800607651;865.2688478235881;885.2563846369081;902.1294450854956;7115.53749006313;9140.90859091414;9157.633694652139;9207.585658645377;9282.767930801783;348819;349360;350491;358637;375590;58035.709821450626;64129.679351603874;72617.2738272621;73226.63386683032;73656;929.400536653868;941.1764705882352;956.0726095687172;981.1464026297167;984.3060642247199;14586.635334116732;14797;14955.551333460013;15014.924925375302;15152.696946061238;33471.832640837616;33571.664283356855;33886.83056584701;34252.82873585716;34884.127896802784;44575.554244458435;46719;46927.29609055935;47045.76477117593;47140.292895605904;7439.9256007439235;7539.849203016019;7540.585267810323;7587.620618968919;7642.656080476503;10538.420386878795;11728.237664551776;11788.29270243788;11923.76152476963;11926.940365298118;10001.249906256915;10300.536475858755;10319.432431216355;10415.635452759117;10473.842892356774;9923.702288931343;10299.639512617023;10386.221033422373;10529.26295159362;10536.10443112344;10317;10406;10408;10649.877174412199;10901.400422976812;7085.681144348414;7341.59621220838;7466.514676546007;7496.812579685551;7582.469227154267;10293.125084367613;10445.425501597485;10601.363918164934;10633.574657013633;10674.412907290174 08:05:46 INFO - PROCESS | 26435 | |3;mootools.html;1288.08545932388;1400.432824705994;1411.760000799864;1546.6751982083763;1734.5490172555133;6639.900401493981;7173.677184526696;7376.520526165809;7388.593627350494;7401.51890127142;7302.890456643141;7509.887351689729;7511.586862722548;7512.098548174226;7519.360854327375;1867.4491025147613;1897.155765684271;1905.199816077244;2164.9891750541265;2198.0658220256405;2247.1797793805226;2298.9310320690406;2302.896369663361;2302.9424264393356;2303.815694744425;2205.2943058221376;2238.2613737466677;2242.5066485373272;2244.091143087044;2265.4902646904397;2177.194438057913;2181.7490988536365;2184.377452426059;2186.7047948526983;2188.0700702201502;2068.1934045722182;2101.936941891746;2102.2642075273534;2105.1684584589;2111.915523379063;7308.744193953186;7344.816379590553;7354.1542722587055;7360.668769905314;7360.705571777123;4333.501647310568;4430.867073987785;4433.778311084465;4452.5992660660695;4455.844045458426;2794.8602569871423;2897.5653651952166;2909.2726818295428;2925.283305590144;2932.545455454408;893.8033632600817;904.1500989070319;906.3700727994046;1671.4818406294087;1705.8294170582967;9924.95037524815;10071.798564028752;10080.294379393445;10100.141487973458;10151.390916545031;3970.8808735737975;4141.275276826544;4178.331466965271;4187.91624167515;4209.431726716854;8085.191480851985;8108.108108108221;8109.229623185788;8118.553479558563;8127.79680507992;4422.867313980586;4500.437445319335;4509.594136527663;4517.887052823706;4527.139843429738;3614.493970844084;4047.6761859051207;4107.712460127762;4108.4453598764385;4112.383142528584;3305.818180000123;3348.2131699050706;3387.983060084684;3388.8983330500123;3416.1118109291265;1029.6859457865423;1030.4023666273542;1033.8035773203067;1036.849656799775;1061.8956285463032;988.6638542895306;1005.6932635546083;1007.8387458006683;1028.8713910761155;1162.5582278734028;7058.082449281561;7084.114485689289;7121.252268511836;7128.572285662877;7132.643367831588;453.9773011349419;459.0154119413839;463.61519938451005;465.9603933665609;467.01226905096155;5503.091989821714;5595.720213989284;5597.6641401516035;5601.159826026047;5605.663660180402;8659.263962563127;9308.627654893864;9323;9351.345405821527;9400.95299523498;9099.49952752605;9210;9212.953935230282;9228;9237.353385262966;7049.08361912948;7247.782566523013;7323.560586364835;7329.157146928172;7341.816454588571;6771.695273712597;6784.76253331131;6798.932010680028;6804.11546498952;6812.625305608239;8033.919660803317;8215;8314;8333.458325208841;8481.660733570834;8488.40581159313;8590.613422395882;8650.43772154808;8652.480851148952;8747.737567872973;5444.373897001737;5736.569757268138;6198.0702894566175;6363.681815909279;6367.3314301997625;6627.204735431779;6639.3692599203;6693.062971184136;6696.7656132035145;6704.564203326768;5916;6015.248093988252;6041.75832966694;6080.452759251689;6113.449789518964;5889.676067816311;5925.111233315038;5941.197938278277;6011.068284415747;6011.128386384037;6327.17746692927;6603.339666033358;6632.137822083098;6632.2372927114;6632.535722499379;6062.151298818258;6070.1198326241565;6097.176881120992;6098.390160984043;6102.786402475892;5921.733521991607;5926.1999630049395;5954.3152537458745;5967.880642387041;6007.158997740407 08:05:46 INFO - PROCESS | 26435 | |4;prototype.html;323.40493491974763;323.47596893033284;323.9335936133093;324.38367102505254;328.19919396672117;5283.788648454062;5393.865153371167;5394.6493477923905;5407.270018547495;5409.702466364353;5312.574994000481;5329.813456529022;5332.893342133155;5333.653312534682;5342.171963345678;3932.862349817757;3998.260321840469;4009.7594144351287;4012.879613611596;4063.8374465021366;4143.937840932388;4169.937450938239;4205.369194620801;4211.136716973013;4227;4135.09028013838;4161.604647558477;4166.187593419285;4167;4179.164167166578;3939.074317535377;4023.2154729827694;4170.77060761658;4185.309423945046;4186.330187170038;3669.522962014921;3689.760165589228;3690.76010059348;3694.18727879866;3697.704183665327;5141.717205553693;5151.227315902607;5155.587552995751;5160.741962901878;5166;4819.855404337875;4833.275008748681;4833.613310935152;4835.202191638376;4840.5159484051665;5646.153077038436;5657.377688454267;5659.886802263973;5664.773409063674;5668.31980162379;4037.1320166164414;4048.5951404859575;4048.7975601220114;4051.9189616207805;4054.776987265699;5668.291463567054;5858.970705146489;5862.648241105548;5943.940560594425;5952.523798096142;3955;3978.403239514038;4008.5590585035625;4050.5544390117066;4058.1680755445063;4111.48606424197;4114;4119.876403707894;4122.690798190088;4123.690723195772;4722.433308003062;4723.7401942893475;4729.125111854318;4736.834210802605;4740.14677358072;5643.633163844419;5657.179708942181;5664.376918538957;5668.093105103246;5672.262605861211;1415.5470249520054;1443.2999995002415;1453.3532578002687;1453.578462245958;1455.3741890986767;923.5520772425368;960.3565611040619;972.6060945317158;977.8337682593834;978.5694294510535;4794.856154315306;4855.635827312965;4931.3835770528685;4932.950670493321;4979.850604481871;5819.621724587888;5847.766089356463;5856.0630299151935;5857.970710146422;5858.443447872445;4949.851504454872;4953.083679519301;4957.529034741694;4963.032208719337;4978.377702787152;3110.424571454243;3144.6383665878716;3149.2441813964483;3150.086474922293;3172.476541370648;5574.358948720868;5575.275214222125;5578.079616863172;5580.35825880029;5584.413636568183;5762.567807414461;5985.40145985398;5994.820155395258;6006.219191505076;6058.21243238385;5546.389897111315;5570.916436253459;5570.997220500268;5572.60991730575;5575.553955683536;5901.7639294427745;5902.61632993854;5904.261967254093;5910.261217347832;5918.704064796657;5770.336411312753;5771;5774.307083150049;5788;5789.2763404574425;5554.1391084381985;5557.444255574572;5562.944370556243;5565.944340556543;5571.220029195997;3909.179072394829;4027.838886444509;4056.6754659626567;4077.1845630874536;4094.1197642507004;5829.183914251923;5849.795257166149;5850.7074646266665;5854.560907931837;5855.473007429352;5652.519535839499;5652.519535839499;5653.236813030353;5655.321361436654;5658.603897727119;5642.6614403135945;5643.52030077448;5649.039663257174;5657.207990881362;5658.462446067617;5558.166275058612;5558.610897237155;5567.749451274622;5573.637713548606;5574.804881829279;5550.58370622213;5675.716214189191;5693.373728889902;5705.429457054262;5710;5526.889462210814;5554.194641776839;5565.443455654402;5565.6104072714525;5572.442755724395 08:05:46 INFO - PROCESS | 26435 | |5;yui.html;738.7956740397882;741.8367959049008;754.3361841579409;755.5466719968018;768.8885111658813;11111.666650000492;11121.16591255656;11187.440627968599;11203.775924481506;11247.831282530748;11628.651140465778;11679.240849344787;11690.415479226047;11748;11792.35142067186;633.4678869749421;770.5299767142039;790.608648718885;792.2790260862616;793.7380664380769;784.9293563579276;788.365365880466;792.3977776889548;792.8771040488705;795.6300320351036;674.3324109131948;833.3250067445358;834.0825092398373;834.2616784146014;835.807764214231;669.3473862983601;669.725412580842;811.0915774332756;823.625250511022;825.3850881093624;600.9369016253318;602.4457499100838;602.9005214139662;603.2248560599609;603.5473394953784;12094.697632559168;12138.575149869801;12224.755504889941;12247.816282755766;12317.753644927141;11776.882231177664;12307.90744597431;12576.559820406334;12673.619791406272;12694.174878632859;9567.760805979837;9657.22742180624;9790.608375665037;9832.967538408508;10003.649872254437;3347.4142025145748;3361.882334118319;3416.8633254669785;3418.453047512386;3474.3572439098593;40604.39093413601;41284.38073428901;41299.38050929239;41306.79346603278;41662.58337416617;8110.107888132301;8216.46592971455;8582.914170858336;8673.306135509145;8799.29605631548;15177.772333415007;15298.694026119638;15980.76028859568;16019.43931962399;16026.679466410607;5975.551833612496;6228.003519436868;6610.8016759497295;6767.1202743644;6934.271901450275;3579.6420357963993;3635.2184280379847;3655.214128962286;3688.61269566697;3765.359888818907;2739.342557786117;2742.314421394651;2759.4756996171063;2761.1716485054403;2775.5697866830674;465.59260646933933;510.46656244224874;515.3403643336535;520.9609279304067;528.4530510921178;444.8394159496729;456.4864527406668;564.7486868343548;565.3385538919474;572.6335145506879;7839.490433121943;8008.679652813938;8013.2387423194705;8076.475029123206;8159.102498725136;542.866997585594;566.895124401987;576.4523702482659;588.5850475414908;630.1209812311891;3728.3102626014274;3732.496113024761;3740.139767853409;3838.405047217686;3859.150986782903;52192.73903630458;52313.47686523086;52402.47597524052;52632.47367526276;54521.45478545243;45984.31023534583;46021.76989115033;46643.30035049477;46739.76630116896;46811.5318846814;42116.15767684629;42450.57549424528;42501.149977000285;43595.56404435915;43785.78107109444;7263.891041634485;7271.163816161209;7350.117985841734;7490.70037198506;7497.400207983239;30481.54277685792;30984.845075774476;31353.37293254168;31355.529667054558;31438.528422074145;38845;40027.79986100051;40559.1888162241;40627.59372406238;40636;10186.337888037255;10393.58425662965;10438.21713371485;10828.783424331627;10986;11016.559337626726;11140.832887506533;11151.776964460827;11212.327260364404;11257.49341279628;8529.829403411773;10664.146868250677;10674.14606831467;10953.452327383759;11700.122490813053;10647.89352106469;10752.193585481276;10838.891611084104;11051.005409513182;11080.113590912546;11081.501332439899;11160.386178760245;11187.272827266203;11261.155413343868;11292.378919159524;8993;9066.727998160066;9256.676016339396;9438.197753191056;9616.567254473426;9068.4180195935;9098.636054557743;9120.407173533698;9208.539573021457;9309.394889332172 08:05:46 INFO - PROCESS | 26435 | __end_tp_report 08:05:46 INFO - PROCESS | 26435 | __start_cc_report 08:05:46 INFO - PROCESS | 26435 | _x_x_mozilla_cycle_collect,1801 08:05:46 INFO - PROCESS | 26435 | __end_cc_report 08:05:46 INFO - PROCESS | 26435 | __startTimestamp1459523146255__endTimestamp 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | ------- Summary: start ------- 08:05:46 INFO - PROCESS | 26435 | Number of tests: 6 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#0] dojo.html Cycles:165 Average:4627.92 Median:4761.81 stddev:464.05 (9.7%) stddev-sans-first:438.73 08:05:46 INFO - PROCESS | 26435 | Values: 2648.7 2714.9 2717.6 2717.9 2759.7 4562.5 4658.6 4660.6 4668.3 4690.3 4677.6 4686.4 4723.1 4774.0 4782.3 4282.0 4303.1 4320.0 4373.6 4475.0 4385.8 4424.2 4437.8 4451.5 4472.2 4248.8 4268.7 4314.7 4320.4 4366.8 4304.1 4309.7 4329.5 4351.4 4366.0 4289.7 4290.9 4301.7 4308.9 4333.2 4451.5 4492.9 4498.7 4579.0 4602.6 5022.7 5024.6 5025.5 5026.2 5034.6 5044.9 5053.8 5064.1 5096.1 5105.3 4602.9 4639.7 4702.3 4718.6 4724.9 5081.3 5082.2 5090.5 5105.3 5140.3 4878.1 4885.2 4885.7 4888.5 4930.8 4942.5 4998.1 5024.5 5091.2 5094.6 4904.3 4918.2 4936.4 4939.5 4994.3 4878.3 4914.4 4916.7 4924.3 4954.5 4243.4 4245.1 4304.8 4310.0 4316.6 3663.1 3697.0 3698.6 3702.4 3737.9 4328.7 4329.4 4329.9 4352.8 4377.3 4894.6 5039.2 5047.9 5130.6 5133.2 4298.7 4302.2 4305.8 4310.1 4353.7 4522.2 4527.7 4529.5 4532.8 4563.0 4624.1 4754.3 4780.5 4830.7 4843.7 5000.2 5001.9 5021.3 5029.2 5074.3 4681.3 4754.4 4761.8 4763.6 4808.3 4921.6 4948.8 4975.0 4982.2 4984.9 4901.1 4909.2 4912.1 4912.8 4917.8 4750.3 4795.0 4796.5 4816.3 4843.2 4797.1 4800.9 4821.0 4826.7 4828.3 4705.4 4740.3 4748.9 4751.9 4774.6 4857.1 4871.7 4876.4 4876.9 4917.1 4800.2 4825.3 4835.8 4869.1 4873.4 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#1] ext.html Cycles:180 Average:39509.19 Median:34689.15 stddev:63282.21 (182.4%) stddev-sans-first:63392.07 08:05:46 INFO - PROCESS | 26435 | Values: 533.5 553.3 554.6 568.7 569.4 27572.0 34696.3 35159.8 35288.1 35410.6 39910.4 40738.4 40761.2 40772.2 40833.4 7810.6 8009.2 8013.8 8014.2 8022.3 7829.1 7941.8 7947.4 7947.6 7974.2 7909.2 7949.6 7994.1 7994.3 7997.2 7871.6 7906.0 7916.0 7917.5 7944.7 7873.4 7991.1 8001.8 8004.5 8012.3 38729.0 38982.4 39117.6 39171.2 39252.2 2840.0 2914.1 2916.3 2995.8 3157.3 28629.4 29052.0 29146.0 29286.6 29918.9 3142.1 3142.7 3145.7 3173.1 3246.9 232724.0 235078.8 235091.0 236029.0 237890.0 41733.0 42567.0 54945.5 55250.7 55417.0 40564.8 40567.4 40623.2 40698.0 40720.6 11913.1 12057.1 12060.8 12064.3 12069.8 9264.2 9312.9 9322.5 9323.5 9323.9 13874.9 14321.2 14457.4 14473.5 14488.2 5761.3 5864.6 5907.5 5973.7 6005.4 880.9 893.6 896.8 913.7 1001.4 25496.0 26330.7 26838.9 26842.2 26864.3 922.5 959.9 982.9 987.1 1031.4 13732.5 14139.8 14151.4 14177.9 14190.6 276561.0 283452.0 284263.0 284875.0 285371.0 46826.8 47669.0 47775.3 47802.0 47854.5 1137.7 1210.1 1214.4 1247.9 1252.2 24361.0 24683.8 24722.1 24822.6 26307.6 37855.6 38123.8 38367.4 38381.4 38418.4 193133.0 193889.0 193949.0 194166.0 237084.0 30962.0 31185.5 31256.5 31271.8 31471.7 34682.0 35613.6 36054.8 36128.5 36196.1 30265.5 30979.2 37181.4 40085.4 40999.6 33526.8 33678.5 33718.8 33910.7 33974.2 33766.2 33928.7 34092.0 34143.0 34440.1 30740.2 30986.7 30993.1 31105.0 31163.5 23773.6 24276.0 24296.8 24678.3 24702.4 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#2] jquery.html Cycles:180 Average:23592.28 Median:179498.97 stddev:58786.37 (32.8%) stddev-sans-first:58925.37 08:05:46 INFO - PROCESS | 26435 | Values: 346.2 347.4 360.9 361.0 362.0 15336.2 15900.9 16053.9 16657.6 16726.2 14972.6 15147.7 15171.6 15189.0 15314.0 4497.3 4585.3 4654.0 4655.6 4666.3 4945.8 4949.7 4992.4 4994.8 4995.7 5004.1 5005.2 5010.7 5010.8 5017.0 4999.6 6129.5 6402.4 6411.7 6416.6 6117.8 6161.0 6165.7 6170.0 6194.1 21167.7 21412.4 22011.6 22016.2 22081.7 1965.4 1979.2 2010.8 2042.6 2070.1 13272.5 13782.4 13823.7 14437.9 14607.8 1845.5 1896.3 1911.6 1982.7 2040.6 67093.7 68811.0 70590.6 70848.3 72064.6 14690.0 14892.9 14966.9 15004.2 15397.9 25191.5 25487.4 25495.2 25496.1 25580.2 7659.4 7824.4 7934.2 7960.8 7986.6 6388.6 6416.4 6470.1 6489.7 6548.1 7458.4 7462.4 7509.9 7547.4 7660.3 2942.3 3025.3 3050.1 3082.6 3188.5 809.4 833.6 880.3 935.0 1000.8 15735.0 15752.9 15803.2 16027.3 16101.0 859.1 859.4 865.3 885.3 902.1 7115.5 9140.9 9157.6 9207.6 9282.8 348819.0 349360.0 350491.0 358637.0 375590.0 58035.7 64129.7 72617.3 73226.6 73656.0 929.4 941.2 956.1 981.1 984.3 14586.6 14797.0 14955.6 15014.9 15152.7 33471.8 33571.7 33886.8 34252.8 34884.1 44575.6 46719.0 46927.3 47045.8 47140.3 7439.9 7539.8 7540.6 7587.6 7642.7 10538.4 11728.2 11788.3 11923.8 11926.9 10001.2 10300.5 10319.4 10415.6 10473.8 9923.7 10299.6 10386.2 10529.3 10536.1 10317.0 10406.0 10408.0 10649.9 10901.4 7085.7 7341.6 7466.5 7496.8 7582.5 10293.1 10445.4 10601.4 10633.6 10674.4 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#3] mootools.html Cycles:180 Average:5135.80 Median:5925.66 stddev:2709.49 (45.7%) stddev-sans-first:2701.65 08:05:46 INFO - PROCESS | 26435 | Values: 1288.1 1400.4 1411.8 1546.7 1734.5 6639.9 7173.7 7376.5 7388.6 7401.5 7302.9 7509.9 7511.6 7512.1 7519.4 1867.4 1897.2 1905.2 2165.0 2198.1 2247.2 2298.9 2302.9 2302.9 2303.8 2205.3 2238.3 2242.5 2244.1 2265.5 2177.2 2181.7 2184.4 2186.7 2188.1 2068.2 2101.9 2102.3 2105.2 2111.9 7308.7 7344.8 7354.2 7360.7 7360.7 4333.5 4430.9 4433.8 4452.6 4455.8 2794.9 2897.6 2909.3 2925.3 2932.5 893.8 904.2 906.4 1671.5 1705.8 9925.0 10071.8 10080.3 10100.1 10151.4 3970.9 4141.3 4178.3 4187.9 4209.4 8085.2 8108.1 8109.2 8118.6 8127.8 4422.9 4500.4 4509.6 4517.9 4527.1 3614.5 4047.7 4107.7 4108.4 4112.4 3305.8 3348.2 3388.0 3388.9 3416.1 1029.7 1030.4 1033.8 1036.8 1061.9 988.7 1005.7 1007.8 1028.9 1162.6 7058.1 7084.1 7121.3 7128.6 7132.6 454.0 459.0 463.6 466.0 467.0 5503.1 5595.7 5597.7 5601.2 5605.7 8659.3 9308.6 9323.0 9351.3 9401.0 9099.5 9210.0 9213.0 9228.0 9237.4 7049.1 7247.8 7323.6 7329.2 7341.8 6771.7 6784.8 6798.9 6804.1 6812.6 8033.9 8215.0 8314.0 8333.5 8481.7 8488.4 8590.6 8650.4 8652.5 8747.7 5444.4 5736.6 6198.1 6363.7 6367.3 6627.2 6639.4 6693.1 6696.8 6704.6 5916.0 6015.2 6041.8 6080.5 6113.4 5889.7 5925.1 5941.2 6011.1 6011.1 6327.2 6603.3 6632.1 6632.2 6632.5 6062.2 6070.1 6097.2 6098.4 6102.8 5921.7 5926.2 5954.3 5967.9 6007.2 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#4] prototype.html Cycles:180 Average:4690.07 Median:5368.02 stddev:1378.21 (25.7%) stddev-sans-first:1342.54 08:05:46 INFO - PROCESS | 26435 | Values: 323.4 323.5 323.9 324.4 328.2 5283.8 5393.9 5394.6 5407.3 5409.7 5312.6 5329.8 5332.9 5333.7 5342.2 3932.9 3998.3 4009.8 4012.9 4063.8 4143.9 4169.9 4205.4 4211.1 4227.0 4135.1 4161.6 4166.2 4167.0 4179.2 3939.1 4023.2 4170.8 4185.3 4186.3 3669.5 3689.8 3690.8 3694.2 3697.7 5141.7 5151.2 5155.6 5160.7 5166.0 4819.9 4833.3 4833.6 4835.2 4840.5 5646.2 5657.4 5659.9 5664.8 5668.3 4037.1 4048.6 4048.8 4051.9 4054.8 5668.3 5859.0 5862.6 5943.9 5952.5 3955.0 3978.4 4008.6 4050.6 4058.2 4111.5 4114.0 4119.9 4122.7 4123.7 4722.4 4723.7 4729.1 4736.8 4740.1 5643.6 5657.2 5664.4 5668.1 5672.3 1415.5 1443.3 1453.4 1453.6 1455.4 923.6 960.4 972.6 977.8 978.6 4794.9 4855.6 4931.4 4933.0 4979.9 5819.6 5847.8 5856.1 5858.0 5858.4 4949.9 4953.1 4957.5 4963.0 4978.4 3110.4 3144.6 3149.2 3150.1 3172.5 5574.4 5575.3 5578.1 5580.4 5584.4 5762.6 5985.4 5994.8 6006.2 6058.2 5546.4 5570.9 5571.0 5572.6 5575.6 5901.8 5902.6 5904.3 5910.3 5918.7 5770.3 5771.0 5774.3 5788.0 5789.3 5554.1 5557.4 5562.9 5565.9 5571.2 3909.2 4027.8 4056.7 4077.2 4094.1 5829.2 5849.8 5850.7 5854.6 5855.5 5652.5 5652.5 5653.2 5655.3 5658.6 5642.7 5643.5 5649.0 5657.2 5658.5 5558.2 5558.6 5567.7 5573.6 5574.8 5550.6 5675.7 5693.4 5705.4 5710.0 5526.9 5554.2 5565.4 5565.6 5572.4 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - PROCESS | 26435 | [#5] yui.html Cycles:180 Average:12510.65 Median:450.66 stddev:14362.83 (3187.0%) stddev-sans-first:14375.91 08:05:46 INFO - PROCESS | 26435 | Values: 738.8 741.8 754.3 755.5 768.9 11111.7 11121.2 11187.4 11203.8 11247.8 11628.7 11679.2 11690.4 11748.0 11792.4 633.5 770.5 790.6 792.3 793.7 784.9 788.4 792.4 792.9 795.6 674.3 833.3 834.1 834.3 835.8 669.3 669.7 811.1 823.6 825.4 600.9 602.4 602.9 603.2 603.5 12094.7 12138.6 12224.8 12247.8 12317.8 11776.9 12307.9 12576.6 12673.6 12694.2 9567.8 9657.2 9790.6 9833.0 10003.6 3347.4 3361.9 3416.9 3418.5 3474.4 40604.4 41284.4 41299.4 41306.8 41662.6 8110.1 8216.5 8582.9 8673.3 8799.3 15177.8 15298.7 15980.8 16019.4 16026.7 5975.6 6228.0 6610.8 6767.1 6934.3 3579.6 3635.2 3655.2 3688.6 3765.4 2739.3 2742.3 2759.5 2761.2 2775.6 465.6 510.5 515.3 521.0 528.5 444.8 456.5 564.7 565.3 572.6 7839.5 8008.7 8013.2 8076.5 8159.1 542.9 566.9 576.5 588.6 630.1 3728.3 3732.5 3740.1 3838.4 3859.2 52192.7 52313.5 52402.5 52632.5 54521.5 45984.3 46021.8 46643.3 46739.8 46811.5 42116.2 42450.6 42501.1 43595.6 43785.8 7263.9 7271.2 7350.1 7490.7 7497.4 30481.5 30984.8 31353.4 31355.5 31438.5 38845.0 40027.8 40559.2 40627.6 40636.0 10186.3 10393.6 10438.2 10828.8 10986.0 11016.6 11140.8 11151.8 11212.3 11257.5 8529.8 10664.1 10674.1 10953.5 11700.1 10647.9 10752.2 10838.9 11051.0 11080.1 11081.5 11160.4 11187.3 11261.2 11292.4 8993.0 9066.7 9256.7 9438.2 9616.6 9068.4 9098.6 9120.4 9208.5 9309.4 08:05:46 INFO - PROCESS | 26435 | -------- Summary: end -------- 08:05:46 INFO - PROCESS | 26435 | 08:05:46 INFO - TEST-INFO | 26435: exit 0 08:05:46 INFO - TEST-OK | dromaeo_css | took 1118154ms 08:05:46 INFO - TEST-START | kraken 08:05:46 INFO - operating with platform_type : linux_ 08:05:46 INFO - Initialising browser for kraken test... 08:05:46 INFO - TEST-INFO | started process 26612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RtCsd/profile http://localhost:52517/getInfo.html) 08:05:51 INFO - PROCESS | 26612 | __metrics Screen width/height:1600/1200 08:05:51 INFO - PROCESS | 26612 | colorDepth:24 08:05:51 INFO - PROCESS | 26612 | Browser inner width/height: 1024/697 08:05:51 INFO - PROCESS | 26612 | __metrics 08:05:52 ERROR - PROCESS | 26612 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:05:53 INFO - TEST-INFO | 26612: exit 0 08:05:53 INFO - Browser initialized. 08:05:53 INFO - Running cycle 1/1 for kraken test... 08:05:53 INFO - TEST-INFO | started process 26693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RtCsd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:05 INFO - PROCESS | 26693 | RSS: Main: 154640384 08:06:05 INFO - PROCESS | 26693 | 08:06:07 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52517/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:08 INFO - PROCESS | 26693 | RSS: Main: 195706880 08:06:08 INFO - PROCESS | 26693 | 08:06:11 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52517/tests/kraken/driver.html?testName=audio-dft) 08:06:11 INFO - PROCESS | 26693 | RSS: Main: 186105856 08:06:11 INFO - PROCESS | 26693 | 08:06:14 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52517/tests/kraken/driver.html?testName=audio-fft) 08:06:15 INFO - PROCESS | 26693 | RSS: Main: 171466752 08:06:15 INFO - PROCESS | 26693 | 08:06:17 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52517/tests/kraken/driver.html?testName=audio-oscillator) 08:06:18 INFO - PROCESS | 26693 | RSS: Main: 171778048 08:06:18 INFO - PROCESS | 26693 | 08:06:20 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52517/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:21 INFO - PROCESS | 26693 | RSS: Main: 174215168 08:06:21 INFO - PROCESS | 26693 | 08:06:24 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52517/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:24 INFO - PROCESS | 26693 | RSS: Main: 173707264 08:06:24 INFO - PROCESS | 26693 | 08:06:28 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52517/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:28 INFO - PROCESS | 26693 | RSS: Main: 171487232 08:06:28 INFO - PROCESS | 26693 | 08:06:31 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52517/tests/kraken/driver.html?testName=json-parse-financial) 08:06:32 INFO - PROCESS | 26693 | RSS: Main: 172191744 08:06:32 INFO - PROCESS | 26693 | 08:06:34 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52517/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:34 INFO - PROCESS | 26693 | RSS: Main: 183697408 08:06:34 INFO - PROCESS | 26693 | 08:06:36 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:37 INFO - PROCESS | 26693 | RSS: Main: 183009280 08:06:37 INFO - PROCESS | 26693 | 08:06:39 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:39 INFO - PROCESS | 26693 | RSS: Main: 196784128 08:06:39 INFO - PROCESS | 26693 | 08:06:42 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:42 INFO - PROCESS | 26693 | RSS: Main: 198774784 08:06:42 INFO - PROCESS | 26693 | 08:06:45 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:46 INFO - PROCESS | 26693 | RSS: Main: 198545408 08:06:46 INFO - PROCESS | 26693 | 08:06:47 INFO - PROCESS | 26693 | Cycle 1(1): loaded http://localhost:52517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52517/tests/kraken/driver.html?testName=ai-astar) 08:06:48 INFO - PROCESS | 26693 | RSS: Main: 260538368 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | __start_tp_report 08:06:48 INFO - PROCESS | 26693 | _x_x_mozilla_page_load 08:06:48 INFO - PROCESS | 26693 | _x_x_mozilla_page_load_details 08:06:48 INFO - PROCESS | 26693 | |i|pagename|runs| 08:06:48 INFO - PROCESS | 26693 | |0;ai-astar;110;112;109;112;113;114;100;112;112;113 08:06:48 INFO - PROCESS | 26693 | |1;audio-beat-detection;166;135;161;178;139;163;157;144;182;134 08:06:48 INFO - PROCESS | 26693 | |2;audio-dft;160;161;162;161;161;162;161;162;163;162 08:06:48 INFO - PROCESS | 26693 | |3;audio-fft;77;77;112;111;79;74;74;120;96;73 08:06:48 INFO - PROCESS | 26693 | |4;audio-oscillator;95;95;130;94;95;94;146;95;94;137 08:06:48 INFO - PROCESS | 26693 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 08:06:48 INFO - PROCESS | 26693 | |6;imaging-darkroom;145;145;146;147;145;145;145;146;145;145 08:06:48 INFO - PROCESS | 26693 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;96 08:06:48 INFO - PROCESS | 26693 | |8;json-parse-financial;65;65;65;65;64;67;66;73;63;62 08:06:48 INFO - PROCESS | 26693 | |9;json-stringify-tinderbox;63;63;63;64;64;64;70;63;64;64 08:06:48 INFO - PROCESS | 26693 | |10;stanford-crypto-aes;79;83;82;80;89;81;82;82;81;82 08:06:48 INFO - PROCESS | 26693 | |11;stanford-crypto-ccm;123;123;121;118;119;125;118;119;118;116 08:06:48 INFO - PROCESS | 26693 | |12;stanford-crypto-pbkdf2;152;144;134;139;142;130;146;147;144;139 08:06:48 INFO - PROCESS | 26693 | |13;stanford-crypto-sha256-iterative;67;69;69;71;69;68;70;70;68;67 08:06:48 INFO - PROCESS | 26693 | __end_tp_report 08:06:48 INFO - PROCESS | 26693 | __start_cc_report 08:06:48 INFO - PROCESS | 26693 | _x_x_mozilla_cycle_collect,1197 08:06:48 INFO - PROCESS | 26693 | __end_cc_report 08:06:48 INFO - PROCESS | 26693 | __startTimestamp1459523208043__endTimestamp 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | ------- Summary: start ------- 08:06:48 INFO - PROCESS | 26693 | Number of tests: 14 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 08:06:48 INFO - PROCESS | 26693 | Values: 110.0 112.0 109.0 112.0 113.0 114.0 100.0 112.0 112.0 113.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:162.00 stddev:17.30 (10.7%) stddev-sans-first:17.96 08:06:48 INFO - PROCESS | 26693 | Values: 166.0 135.0 161.0 178.0 139.0 163.0 157.0 144.0 182.0 134.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 08:06:48 INFO - PROCESS | 26693 | Values: 160.0 161.0 162.0 161.0 161.0 162.0 161.0 162.0 163.0 162.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.50 stddev:18.61 (24.6%) stddev-sans-first:19.20 08:06:48 INFO - PROCESS | 26693 | Values: 77.0 77.0 112.0 111.0 79.0 74.0 74.0 120.0 96.0 73.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.50 stddev:21.16 (22.4%) stddev-sans-first:21.96 08:06:48 INFO - PROCESS | 26693 | Values: 95.0 95.0 130.0 94.0 95.0 94.0 146.0 95.0 94.0 137.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:06:48 INFO - PROCESS | 26693 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:06:48 INFO - PROCESS | 26693 | Values: 145.0 145.0 146.0 147.0 145.0 145.0 145.0 146.0 145.0 145.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:06:48 INFO - PROCESS | 26693 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:2.99 (4.6%) stddev-sans-first:3.17 08:06:48 INFO - PROCESS | 26693 | Values: 65.0 65.0 65.0 65.0 64.0 67.0 66.0 73.0 63.0 62.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:2.10 (3.3%) stddev-sans-first:2.18 08:06:48 INFO - PROCESS | 26693 | Values: 63.0 63.0 63.0 64.0 64.0 64.0 70.0 63.0 64.0 64.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:2.69 (3.3%) stddev-sans-first:2.60 08:06:48 INFO - PROCESS | 26693 | Values: 79.0 83.0 82.0 80.0 89.0 81.0 82.0 82.0 81.0 82.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.00 stddev:2.87 (2.4%) stddev-sans-first:2.83 08:06:48 INFO - PROCESS | 26693 | Values: 123.0 123.0 121.0 118.0 119.0 125.0 118.0 119.0 118.0 116.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:144.00 stddev:6.45 (4.5%) stddev-sans-first:5.66 08:06:48 INFO - PROCESS | 26693 | Values: 152.0 144.0 134.0 139.0 142.0 130.0 146.0 147.0 144.0 139.0 08:06:48 INFO - PROCESS | 26693 | 08:06:48 INFO - PROCESS | 26693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.22 08:06:48 INFO - PROCESS | 26693 | Values: 67.0 69.0 69.0 71.0 69.0 68.0 70.0 70.0 68.0 67.0 08:06:48 INFO - PROCESS | 26693 | -------- Summary: end -------- 08:06:48 INFO - PROCESS | 26693 | 08:06:49 INFO - TEST-INFO | 26693: exit 0 08:06:49 INFO - TEST-OK | kraken | took 62135ms 08:06:49 INFO - SUITE-END | took 1180s 08:06:49 INFO - Completed test suite (00:19:40) 08:06:49 INFO - javascript benchmark 08:06:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.6821581410236, 2714.8506832124226, 2717.592361145828, 2717.945641087177, 2759.7378249066333, 4562.475315338737, 4658.60401865841, 4660.603848672863, 4668.276417155342, 4690.273007683814, 4677.649176311773, 4686.437627484698, 4723.055388922221, 4774.0, 4782.330473733671, 4281.978590107045, 4303.074838909642, 4320.0, 4373.584509471595, 4475.0378668586245, 4385.780710964471, 4424.181526417623, 4437.778111094449, 4451.5103338632725, 4472.150291444631, 4248.766317852517, 4268.722533035343, 4314.697971142022, 4320.416743739586, 4366.8253269869165, 4304.139172165579, 4309.741415515079, 4329.502107257674, 4351.369051487548, 4366.039471316337, 4289.721168124093, 4290.914181716348, 4301.698881078294, 4308.9138217235795, 4333.2200203963275, 4451.465824101097, 4492.865214043584, 4498.707584007029, 4579.0, 4602.6087782538525, 5022.67352622082, 5024.648274620778, 5025.497450254982, 5026.220935754964, 5034.622403319766, 5044.949550504484, 5053.8231161909525, 5064.11378008847, 5096.133657278272, 5105.310783044279, 4602.88492787683, 4639.721616702941, 4702.294655801623, 4718.551737584924, 4724.858254252378, 5081.2632168335385, 5082.2122571001555, 5090.516400941905, 5105.33630628016, 5140.331756871583, 4878.121938051185, 4885.169521181408, 4885.682430641997, 4888.535589119028, 4930.827421040246, 4942.505749425029, 4998.075356059141, 5024.522670346311, 5091.159958606862, 5094.61790365724, 4904.337914381585, 4918.213085906238, 4936.358273424432, 4939.506049395031, 4994.2508623706735, 4878.268259760993, 4914.385701787277, 4916.72957987307, 4924.3105965164905, 4954.529319714621, 4243.42713733642, 4245.1085272093205, 4304.7632380218765, 4309.978450107729, 4316.633086187647, 3663.084228942764, 3696.9815150924073, 3698.5746639136305, 3702.3891057975134, 3737.9065523362133, 4328.7402755834755, 4329.393884856123, 4329.935050974238, 4352.760598167068, 4377.321515165155, 4894.608431325485, 5039.244113382949, 5047.924281135786, 5130.615203859726, 5133.204353325241, 4298.742075475419, 4302.225599392077, 4305.763183024964, 4310.051788606502, 4353.673474489426, 4522.208613492626, 4527.660425468103, 4529.456465224194, 4532.773361331986, 4563.041761230179, 4624.12141693084, 4754.334393184888, 4780.49804770508, 4830.734309613005, 4843.660943733905, 5000.174971129868, 5001.949980500149, 5021.347224860745, 5029.1953287473825, 5074.264231686311, 4681.274402467623, 4754.405699287589, 4761.809527618995, 4763.618910487084, 4808.326834243278, 4921.581665558468, 4948.752562371939, 4975.0, 4982.153033984304, 4984.925226121683, 4901.117798796251, 4909.214525675875, 4912.140375434356, 4912.82805101834, 4917.803287868588, 4750.311204875343, 4795.0, 4796.472388037383, 4816.325714400057, 4843.2250839865455, 4797.088553174885, 4800.927986080142, 4821.011692602938, 4826.710397376029, 4828.2998965150555, 4705.411823522059, 4740.288956656529, 4748.9314904146295, 4751.904961900674, 4774.618030557616, 4857.101436234308, 4871.732054737024, 4876.390451193601, 4876.853694389174, 4917.139500587311, 4800.207965685762, 4825.30033145199, 4835.830745923876, 4869.123557759637, 4873.439554451284], "unit": "score", "name": "dojo.html", "value": 4599.894506593806}, {"lowerIsBetter": false, "replicates": [533.5331584863247, 553.3028384235866, 554.6006875049964, 568.6929058308514, 569.4078158714937, 27572.0, 34696.306073878506, 35159.82420087899, 35288.117797055085, 35410.64589354112, 39910.401343979865, 40738.38892416616, 40761.18477630446, 40772.18455630893, 40833.387499187535, 7810.609469526516, 8009.199080092002, 8013.799655008613, 8014.198580141969, 8022.277994980451, 7829.138794732575, 7941.761747147595, 7947.443678942476, 7947.602619869012, 7974.1627129151475, 7909.169537198598, 7949.602519874012, 7994.120646728855, 7994.2805147537, 7997.200279971986, 7871.567063811488, 7906.0, 7916.0, 7917.524948503051, 7944.682212711456, 7873.409494287951, 7991.081025682063, 8001.839963200703, 8004.519728816232, 8012.278894899487, 38729.0, 38982.415263771065, 39117.60882391168, 39171.216575668324, 39252.21495570073, 2840.0, 2914.082906306687, 2916.28551005003, 2995.7902946793733, 3157.2896098377682, 28629.421322334707, 29052.0, 29146.0, 29286.560701589493, 29918.85040574805, 3142.0887942496647, 3142.71715545602, 3145.7011583899493, 3173.1273899677544, 3246.8863589774483, 232724.0, 235078.8246058776, 235091.0, 236029.0, 237890.0, 41733.0, 42567.0, 54945.45054549483, 55250.72374638182, 55417.0, 40564.79717601393, 40567.39148912769, 40623.1875362497, 40698.0, 40720.592794072276, 11913.10651701126, 12057.0957178212, 12060.819087713691, 12064.336461494526, 12069.818952715716, 9264.212541934012, 9312.8603070954, 9322.487263200454, 9323.487208203478, 9323.90676093244, 13874.930625347011, 14321.212333321559, 14457.421703131968, 14473.493427729978, 14488.203148826706, 5761.337446193657, 5864.560157988168, 5907.4683278505145, 5973.701314934236, 6005.399460054047, 880.9207171354609, 893.620211410148, 896.8385690575628, 913.7213149989184, 1001.3741411617739, 25496.0, 26330.73669263321, 26838.86580567085, 26842.194734158005, 26864.32839179036, 922.5479515037717, 959.9424034557949, 982.9164521015794, 987.09680642213, 1031.4120951057976, 13732.45070197181, 14139.798117160157, 14151.433942642385, 14177.929110354382, 14190.645233869236, 276561.0, 283452.0, 284263.0, 284875.0, 285371.0, 46826.76586617045, 47669.0, 47775.283370749465, 47802.04395912132, 47854.521454785005, 1137.670075678044, 1210.0924306769923, 1214.40494157862, 1247.9376031198585, 1252.1673087396962, 24360.953337229836, 24683.753162468147, 24722.13472528453, 24822.627660584745, 26307.605385918843, 37855.62144378521, 38123.80938095292, 38367.42448863213, 38381.424278635284, 38418.42372364361, 193133.0, 193889.0, 193949.0, 194166.0, 237084.0, 30962.0, 31185.53221701722, 31256.531152033192, 31271.84364078165, 31471.68528314779, 34682.0, 35613.64386356103, 36054.8197259012, 36128.45807312945, 36196.09509762277, 30265.546016809327, 30979.225519362197, 37181.44227836639, 40085.39871901865, 40999.59000409958, 33526.83236583802, 33678.49482257817, 33718.831405842815, 33910.66089339174, 33974.15064623305, 33766.15584610404, 33928.66071339255, 34091.97724068282, 34143.0, 34440.13899652529, 30740.231494212825, 30986.69013309928, 30993.070207893797, 31105.0, 31163.532547012266, 23773.64339534874, 24275.95312107464, 24296.75703242945, 24678.25965221046, 24702.382440438414], "unit": "score", "name": "ext.html", "value": 16295.80836845882}, {"lowerIsBetter": false, "replicates": [346.18818869750424, 347.37472549411063, 360.93322735293975, 360.9711223102152, 361.95475565554307, 15336.23318834058, 15900.92049539752, 16053.919730401332, 16657.583560410996, 16726.163691815393, 14972.625684357896, 15147.6970460591, 15171.620709482268, 15189.0, 15314.0, 4497.347884556737, 4585.2892801615635, 4653.976730116345, 4655.580997710205, 4666.323383109447, 4945.802167913297, 4949.7030178189425, 4992.425871024824, 4994.825181118662, 4995.675281106716, 5004.074246264435, 5005.174146265862, 5010.6993580385115, 5010.799568017275, 5017.0, 4999.60003199745, 6129.509639228851, 6402.359764023607, 6411.743530258831, 6416.615003099829, 6117.816465506042, 6161.045038019114, 6165.660888651122, 6169.969150154266, 6194.132821404962, 21167.68248476274, 21412.357629271148, 22011.559768804695, 22016.229431969965, 22081.668774968388, 1965.351434026782, 1979.2182088075274, 2010.8190262876412, 2042.6323261812868, 2070.130545171032, 13272.469101235938, 13782.448702051906, 13823.654408639764, 14437.855621443756, 14607.78088328676, 1845.5293900055399, 1896.2983696032418, 1911.5890083631946, 1982.6530357187435, 2040.6428874946973, 67093.66453167703, 68811.0, 70590.64704676444, 70848.2915170852, 72064.63967680128, 14689.988552346744, 14892.851071489364, 14966.850331496764, 15004.24978751058, 15397.9230103851, 25191.49617007686, 25487.36281592938, 25495.23514294574, 25496.107636232642, 25580.23259302224, 7659.4255430841795, 7824.413169012347, 7934.166912474223, 7960.800979975431, 7986.560739159286, 6388.648624325614, 6416.4225219729515, 6470.09418681385, 6489.740410383626, 6548.083268342436, 7458.440616953751, 7462.44031697614, 7509.9249007509225, 7547.433942454338, 7660.310572048543, 2942.3232656489126, 3025.3041800386036, 3050.145959131447, 3082.568440418343, 3188.5217217417107, 809.3929552835374, 833.5748768128299, 880.2781718990367, 935.0, 1000.7798284377425, 15735.0, 15752.921235393978, 15803.20983950798, 16027.278772455267, 16101.0, 859.0593300336246, 859.4284800607651, 865.2688478235881, 885.2563846369081, 902.1294450854956, 7115.53749006313, 9140.90859091414, 9157.633694652139, 9207.585658645377, 9282.767930801783, 348819.0, 349360.0, 350491.0, 358637.0, 375590.0, 58035.709821450626, 64129.679351603874, 72617.2738272621, 73226.63386683032, 73656.0, 929.400536653868, 941.1764705882352, 956.0726095687172, 981.1464026297167, 984.3060642247199, 14586.635334116732, 14797.0, 14955.551333460013, 15014.924925375302, 15152.696946061238, 33471.832640837616, 33571.664283356855, 33886.83056584701, 34252.82873585716, 34884.127896802784, 44575.554244458435, 46719.0, 46927.29609055935, 47045.76477117593, 47140.292895605904, 7439.9256007439235, 7539.849203016019, 7540.585267810323, 7587.620618968919, 7642.656080476503, 10538.420386878795, 11728.237664551776, 11788.29270243788, 11923.76152476963, 11926.940365298118, 10001.249906256915, 10300.536475858755, 10319.432431216355, 10415.635452759117, 10473.842892356774, 9923.702288931343, 10299.639512617023, 10386.221033422373, 10529.26295159362, 10536.10443112344, 10317.0, 10406.0, 10408.0, 10649.877174412199, 10901.400422976812, 7085.681144348414, 7341.59621220838, 7466.514676546007, 7496.812579685551, 7582.469227154267, 10293.125084367613, 10445.425501597485, 10601.363918164934, 10633.574657013633, 10674.412907290174], "unit": "score", "name": "jquery.html", "value": 8689.270187991411}, {"lowerIsBetter": false, "replicates": [1288.08545932388, 1400.432824705994, 1411.760000799864, 1546.6751982083763, 1734.5490172555133, 6639.900401493981, 7173.677184526696, 7376.520526165809, 7388.593627350494, 7401.51890127142, 7302.890456643141, 7509.887351689729, 7511.586862722548, 7512.098548174226, 7519.360854327375, 1867.4491025147613, 1897.155765684271, 1905.199816077244, 2164.9891750541265, 2198.0658220256405, 2247.1797793805226, 2298.9310320690406, 2302.896369663361, 2302.9424264393356, 2303.815694744425, 2205.2943058221376, 2238.2613737466677, 2242.5066485373272, 2244.091143087044, 2265.4902646904397, 2177.194438057913, 2181.7490988536365, 2184.377452426059, 2186.7047948526983, 2188.0700702201502, 2068.1934045722182, 2101.936941891746, 2102.2642075273534, 2105.1684584589, 2111.915523379063, 7308.744193953186, 7344.816379590553, 7354.1542722587055, 7360.668769905314, 7360.705571777123, 4333.501647310568, 4430.867073987785, 4433.778311084465, 4452.5992660660695, 4455.844045458426, 2794.8602569871423, 2897.5653651952166, 2909.2726818295428, 2925.283305590144, 2932.545455454408, 893.8033632600817, 904.1500989070319, 906.3700727994046, 1671.4818406294087, 1705.8294170582967, 9924.95037524815, 10071.798564028752, 10080.294379393445, 10100.141487973458, 10151.390916545031, 3970.8808735737975, 4141.275276826544, 4178.331466965271, 4187.91624167515, 4209.431726716854, 8085.191480851985, 8108.108108108221, 8109.229623185788, 8118.553479558563, 8127.79680507992, 4422.867313980586, 4500.437445319335, 4509.594136527663, 4517.887052823706, 4527.139843429738, 3614.493970844084, 4047.6761859051207, 4107.712460127762, 4108.4453598764385, 4112.383142528584, 3305.818180000123, 3348.2131699050706, 3387.983060084684, 3388.8983330500123, 3416.1118109291265, 1029.6859457865423, 1030.4023666273542, 1033.8035773203067, 1036.849656799775, 1061.8956285463032, 988.6638542895306, 1005.6932635546083, 1007.8387458006683, 1028.8713910761155, 1162.5582278734028, 7058.082449281561, 7084.114485689289, 7121.252268511836, 7128.572285662877, 7132.643367831588, 453.9773011349419, 459.0154119413839, 463.61519938451005, 465.9603933665609, 467.01226905096155, 5503.091989821714, 5595.720213989284, 5597.6641401516035, 5601.159826026047, 5605.663660180402, 8659.263962563127, 9308.627654893864, 9323.0, 9351.345405821527, 9400.95299523498, 9099.49952752605, 9210.0, 9212.953935230282, 9228.0, 9237.353385262966, 7049.08361912948, 7247.782566523013, 7323.560586364835, 7329.157146928172, 7341.816454588571, 6771.695273712597, 6784.76253331131, 6798.932010680028, 6804.11546498952, 6812.625305608239, 8033.919660803317, 8215.0, 8314.0, 8333.458325208841, 8481.660733570834, 8488.40581159313, 8590.613422395882, 8650.43772154808, 8652.480851148952, 8747.737567872973, 5444.373897001737, 5736.569757268138, 6198.0702894566175, 6363.681815909279, 6367.3314301997625, 6627.204735431779, 6639.3692599203, 6693.062971184136, 6696.7656132035145, 6704.564203326768, 5916.0, 6015.248093988252, 6041.75832966694, 6080.452759251689, 6113.449789518964, 5889.676067816311, 5925.111233315038, 5941.197938278277, 6011.068284415747, 6011.128386384037, 6327.17746692927, 6603.339666033358, 6632.137822083098, 6632.2372927114, 6632.535722499379, 6062.151298818258, 6070.1198326241565, 6097.176881120992, 6098.390160984043, 6102.786402475892, 5921.733521991607, 5926.1999630049395, 5954.3152537458745, 5967.880642387041, 6007.158997740407], "unit": "score", "name": "mootools.html", "value": 4149.969438421166}, {"lowerIsBetter": false, "replicates": [323.40493491974763, 323.47596893033284, 323.9335936133093, 324.38367102505254, 328.19919396672117, 5283.788648454062, 5393.865153371167, 5394.6493477923905, 5407.270018547495, 5409.702466364353, 5312.574994000481, 5329.813456529022, 5332.893342133155, 5333.653312534682, 5342.171963345678, 3932.862349817757, 3998.260321840469, 4009.7594144351287, 4012.879613611596, 4063.8374465021366, 4143.937840932388, 4169.937450938239, 4205.369194620801, 4211.136716973013, 4227.0, 4135.09028013838, 4161.604647558477, 4166.187593419285, 4167.0, 4179.164167166578, 3939.074317535377, 4023.2154729827694, 4170.77060761658, 4185.309423945046, 4186.330187170038, 3669.522962014921, 3689.760165589228, 3690.76010059348, 3694.18727879866, 3697.704183665327, 5141.717205553693, 5151.227315902607, 5155.587552995751, 5160.741962901878, 5166.0, 4819.855404337875, 4833.275008748681, 4833.613310935152, 4835.202191638376, 4840.5159484051665, 5646.153077038436, 5657.377688454267, 5659.886802263973, 5664.773409063674, 5668.31980162379, 4037.1320166164414, 4048.5951404859575, 4048.7975601220114, 4051.9189616207805, 4054.776987265699, 5668.291463567054, 5858.970705146489, 5862.648241105548, 5943.940560594425, 5952.523798096142, 3955.0, 3978.403239514038, 4008.5590585035625, 4050.5544390117066, 4058.1680755445063, 4111.48606424197, 4114.0, 4119.876403707894, 4122.690798190088, 4123.690723195772, 4722.433308003062, 4723.7401942893475, 4729.125111854318, 4736.834210802605, 4740.14677358072, 5643.633163844419, 5657.179708942181, 5664.376918538957, 5668.093105103246, 5672.262605861211, 1415.5470249520054, 1443.2999995002415, 1453.3532578002687, 1453.578462245958, 1455.3741890986767, 923.5520772425368, 960.3565611040619, 972.6060945317158, 977.8337682593834, 978.5694294510535, 4794.856154315306, 4855.635827312965, 4931.3835770528685, 4932.950670493321, 4979.850604481871, 5819.621724587888, 5847.766089356463, 5856.0630299151935, 5857.970710146422, 5858.443447872445, 4949.851504454872, 4953.083679519301, 4957.529034741694, 4963.032208719337, 4978.377702787152, 3110.424571454243, 3144.6383665878716, 3149.2441813964483, 3150.086474922293, 3172.476541370648, 5574.358948720868, 5575.275214222125, 5578.079616863172, 5580.35825880029, 5584.413636568183, 5762.567807414461, 5985.40145985398, 5994.820155395258, 6006.219191505076, 6058.21243238385, 5546.389897111315, 5570.916436253459, 5570.997220500268, 5572.60991730575, 5575.553955683536, 5901.7639294427745, 5902.61632993854, 5904.261967254093, 5910.261217347832, 5918.704064796657, 5770.336411312753, 5771.0, 5774.307083150049, 5788.0, 5789.2763404574425, 5554.1391084381985, 5557.444255574572, 5562.944370556243, 5565.944340556543, 5571.220029195997, 3909.179072394829, 4027.838886444509, 4056.6754659626567, 4077.1845630874536, 4094.1197642507004, 5829.183914251923, 5849.795257166149, 5850.7074646266665, 5854.560907931837, 5855.473007429352, 5652.519535839499, 5652.519535839499, 5653.236813030353, 5655.321361436654, 5658.603897727119, 5642.6614403135945, 5643.52030077448, 5649.039663257174, 5657.207990881362, 5658.462446067617, 5558.166275058612, 5558.610897237155, 5567.749451274622, 5573.637713548606, 5574.804881829279, 5550.58370622213, 5675.716214189191, 5693.373728889902, 5705.429457054262, 5710.0, 5526.889462210814, 5554.194641776839, 5565.443455654402, 5565.6104072714525, 5572.442755724395], "unit": "score", "name": "prototype.html", "value": 4250.5438895359775}, {"lowerIsBetter": false, "replicates": [738.7956740397882, 741.8367959049008, 754.3361841579409, 755.5466719968018, 768.8885111658813, 11111.666650000492, 11121.16591255656, 11187.440627968599, 11203.775924481506, 11247.831282530748, 11628.651140465778, 11679.240849344787, 11690.415479226047, 11748.0, 11792.35142067186, 633.4678869749421, 770.5299767142039, 790.608648718885, 792.2790260862616, 793.7380664380769, 784.9293563579276, 788.365365880466, 792.3977776889548, 792.8771040488705, 795.6300320351036, 674.3324109131948, 833.3250067445358, 834.0825092398373, 834.2616784146014, 835.807764214231, 669.3473862983601, 669.725412580842, 811.0915774332756, 823.625250511022, 825.3850881093624, 600.9369016253318, 602.4457499100838, 602.9005214139662, 603.2248560599609, 603.5473394953784, 12094.697632559168, 12138.575149869801, 12224.755504889941, 12247.816282755766, 12317.753644927141, 11776.882231177664, 12307.90744597431, 12576.559820406334, 12673.619791406272, 12694.174878632859, 9567.760805979837, 9657.22742180624, 9790.608375665037, 9832.967538408508, 10003.649872254437, 3347.4142025145748, 3361.882334118319, 3416.8633254669785, 3418.453047512386, 3474.3572439098593, 40604.39093413601, 41284.38073428901, 41299.38050929239, 41306.79346603278, 41662.58337416617, 8110.107888132301, 8216.46592971455, 8582.914170858336, 8673.306135509145, 8799.29605631548, 15177.772333415007, 15298.694026119638, 15980.76028859568, 16019.43931962399, 16026.679466410607, 5975.551833612496, 6228.003519436868, 6610.8016759497295, 6767.1202743644, 6934.271901450275, 3579.6420357963993, 3635.2184280379847, 3655.214128962286, 3688.61269566697, 3765.359888818907, 2739.342557786117, 2742.314421394651, 2759.4756996171063, 2761.1716485054403, 2775.5697866830674, 465.59260646933933, 510.46656244224874, 515.3403643336535, 520.9609279304067, 528.4530510921178, 444.8394159496729, 456.4864527406668, 564.7486868343548, 565.3385538919474, 572.6335145506879, 7839.490433121943, 8008.679652813938, 8013.2387423194705, 8076.475029123206, 8159.102498725136, 542.866997585594, 566.895124401987, 576.4523702482659, 588.5850475414908, 630.1209812311891, 3728.3102626014274, 3732.496113024761, 3740.139767853409, 3838.405047217686, 3859.150986782903, 52192.73903630458, 52313.47686523086, 52402.47597524052, 52632.47367526276, 54521.45478545243, 45984.31023534583, 46021.76989115033, 46643.30035049477, 46739.76630116896, 46811.5318846814, 42116.15767684629, 42450.57549424528, 42501.149977000285, 43595.56404435915, 43785.78107109444, 7263.891041634485, 7271.163816161209, 7350.117985841734, 7490.70037198506, 7497.400207983239, 30481.54277685792, 30984.845075774476, 31353.37293254168, 31355.529667054558, 31438.528422074145, 38845.0, 40027.79986100051, 40559.1888162241, 40627.59372406238, 40636.0, 10186.337888037255, 10393.58425662965, 10438.21713371485, 10828.783424331627, 10986.0, 11016.559337626726, 11140.832887506533, 11151.776964460827, 11212.327260364404, 11257.49341279628, 8529.829403411773, 10664.146868250677, 10674.14606831467, 10953.452327383759, 11700.122490813053, 10647.89352106469, 10752.193585481276, 10838.891611084104, 11051.005409513182, 11080.113590912546, 11081.501332439899, 11160.386178760245, 11187.272827266203, 11261.155413343868, 11292.378919159524, 8993.0, 9066.727998160066, 9256.676016339396, 9438.197753191056, 9616.567254473426, 9068.4180195935, 9098.636054557743, 9120.407173533698, 9208.539573021457, 9309.394889332172], "unit": "score", "name": "yui.html", "value": 5754.519654067278}], "name": "dromaeo_css", "value": 6359.039451158349}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 109.0, 112.0, 113.0, 114.0, 100.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [166.0, 135.0, 161.0, 178.0, 139.0, 163.0, 157.0, 144.0, 182.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 155.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 112.0, 111.0, 79.0, 74.0, 74.0, 120.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 94.0, 95.0, 94.0, 146.0, 95.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 67.0, 66.0, 73.0, 63.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 70.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [79.0, 83.0, 82.0, 80.0, 89.0, 81.0, 82.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 121.0, 118.0, 119.0, 125.0, 118.0, 119.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [152.0, 144.0, 134.0, 139.0, 142.0, 130.0, 146.0, 147.0, 144.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 71.0, 69.0, 68.0, 70.0, 70.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1524.4999999999998}]} 08:06:49 INFO - Return code: 0 08:06:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:06:49 ERROR - # TBPL SUCCESS # 08:06:49 INFO - Running post-action listener: _resource_record_post_action 08:06:49 INFO - Running post-run listener: _resource_record_post_run 08:06:50 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 396320768; Read time: 0; Write time: 430576 08:06:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108630016; Read time: 0; Write time: 109588 08:06:50 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 280350720; Read time: 0; Write time: 320492 08:06:50 INFO - Running post-run listener: _upload_blobber_files 08:06:50 INFO - Blob upload gear active. 08:06:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:50 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 08:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:06:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:51 INFO - (blobuploader) - INFO - Done attempting. 08:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:06:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:52 INFO - (blobuploader) - INFO - Done attempting. 08:06:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:06:52 INFO - Return code: 0 08:06:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:06:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:06:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d1c73c037d85d6204e99e69c60881db1693b41447a78283d5749223ec7bd32d1f0a7bab3e2e763946bc1e34376d594b6e44c9b4a73347876aca5537ccea80b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/641a054c56c0408492227c998ab6d93eb7e00395506c94e0a371eb846ffeff0622b34e7e8afb1800aff32d1cb5e79b0f13a7b2b2cbb159b706d31c3aebd22d1c"} 08:06:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:06:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:06:52 INFO - Contents: 08:06:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d1c73c037d85d6204e99e69c60881db1693b41447a78283d5749223ec7bd32d1f0a7bab3e2e763946bc1e34376d594b6e44c9b4a73347876aca5537ccea80b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/641a054c56c0408492227c998ab6d93eb7e00395506c94e0a371eb846ffeff0622b34e7e8afb1800aff32d1cb5e79b0f13a7b2b2cbb159b706d31c3aebd22d1c"} 08:06:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:06:52 INFO - Copying logs to upload dir... 08:06:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:06:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.625348 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-01 08:06:52.309934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 08:06:52.313615) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d1c73c037d85d6204e99e69c60881db1693b41447a78283d5749223ec7bd32d1f0a7bab3e2e763946bc1e34376d594b6e44c9b4a73347876aca5537ccea80b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/641a054c56c0408492227c998ab6d93eb7e00395506c94e0a371eb846ffeff0622b34e7e8afb1800aff32d1cb5e79b0f13a7b2b2cbb159b706d31c3aebd22d1c"} build_url:https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/RVGpPROKQoOJ5YPOLLz2GQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60d1c73c037d85d6204e99e69c60881db1693b41447a78283d5749223ec7bd32d1f0a7bab3e2e763946bc1e34376d594b6e44c9b4a73347876aca5537ccea80b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/641a054c56c0408492227c998ab6d93eb7e00395506c94e0a371eb846ffeff0622b34e7e8afb1800aff32d1cb5e79b0f13a7b2b2cbb159b706d31c3aebd22d1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 08:06:52.338655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 08:06:52.338972) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459521442.303999-1200617989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 08:06:52.390096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 08:06:52.390427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 08:06:52.390723) ========= ========= Total master_lag: 0.92 =========