builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1459515190.06 results: success (0) buildid: 20160401045338 builduid: 801a43ad9cfd476d8596f286d402e717 revision: d2d93c1d2ee32c4045ad623a794071d6bf78ea79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.059720) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.060254) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.060551) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006343 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.089619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.089930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.106353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.106686) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.159960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.160439) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.160792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.161069) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 05:53:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-01 05:53:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.269065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.269358) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.320307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.320618) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d2d93c1d2ee32c4045ad623a794071d6bf78ea79 --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 d2d93c1d2ee32c4045ad623a794071d6bf78ea79 --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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 05:53:13,154 truncating revision to first 12 chars 2016-04-01 05:53:13,155 Setting DEBUG logging. 2016-04-01 05:53:13,155 attempt 1/10 2016-04-01 05:53:13,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d2d93c1d2ee3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 05:53:13,390 unpacking tar archive at: fx-team-d2d93c1d2ee3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.839431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.839898) ========= echo d2d93c1d2ee32c4045ad623a794071d6bf78ea79 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd2d93c1d2ee32c4045ad623a794071d6bf78ea79'] 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d2d93c1d2ee32c4045ad623a794071d6bf78ea79 program finished with exit code 0 elapsedTime=0.004720 script_repo_revision: 'd2d93c1d2ee32c4045ad623a794071d6bf78ea79' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.892054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.892488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 05:53:10.903222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-01 05:53:10.903672) ========= /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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:13 INFO - MultiFileLogger online at 20160401 05:53:13 in /builds/slave/test 05:53:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:53:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:13 INFO - {'append_to_log': False, 05:53:13 INFO - 'base_work_dir': '/builds/slave/test', 05:53:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:53:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:13 INFO - 'branch': 'Fx-Team-Non-PGO', 05:53:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:13 INFO - 'config_files': ('talos/linux_config.py',), 05:53:13 INFO - 'default_actions': ('clobber', 05:53:13 INFO - 'read-buildbot-config', 05:53:13 INFO - 'download-and-extract', 05:53:13 INFO - 'populate-webroot', 05:53:13 INFO - 'create-virtualenv', 05:53:13 INFO - 'install', 05:53:13 INFO - 'run-tests'), 05:53:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:13 INFO - 'download_minidump_stackwalk': True, 05:53:13 INFO - 'download_symbols': 'ondemand', 05:53:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:13 INFO - 'installer_path': 'installer.exe', 05:53:13 INFO - 'log_level': 'info', 05:53:13 INFO - 'log_name': 'talos', 05:53:13 INFO - 'log_to_console': True, 05:53:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:13 INFO - 'opt_config_files': (), 05:53:13 INFO - 'pip_index': False, 05:53:13 INFO - 'sps_profile': False, 05:53:13 INFO - 'sps_profile_interval': 0, 05:53:13 INFO - 'suite': 'dromaeojs', 05:53:13 INFO - 'system_bits': '32', 05:53:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:13 INFO - 'title': 'talos-linux64-ix-059', 05:53:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:13 INFO - 'use_talos_json': True, 05:53:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:13 INFO - 'work_dir': 'build'} 05:53:13 INFO - ##### 05:53:13 INFO - ##### Running clobber step. 05:53:13 INFO - ##### 05:53:13 INFO - Running pre-action listener: _resource_record_pre_action 05:53:13 INFO - Running main action method: clobber 05:53:13 INFO - rmtree: /builds/slave/test/build 05:53:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:14 INFO - Running post-action listener: _resource_record_post_action 05:53:14 INFO - ##### 05:53:14 INFO - ##### Running read-buildbot-config step. 05:53:14 INFO - ##### 05:53:14 INFO - Running pre-action listener: _resource_record_pre_action 05:53:14 INFO - Running main action method: read_buildbot_config 05:53:14 INFO - Using buildbot properties: 05:53:14 INFO - { 05:53:14 INFO - "project": "", 05:53:14 INFO - "product": "firefox", 05:53:14 INFO - "script_repo_revision": "production", 05:53:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:53:14 INFO - "repository": "", 05:53:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:53:14 INFO - "buildid": "20160401045338", 05:53:14 INFO - "pgo_build": "False", 05:53:14 INFO - "basedir": "/builds/slave/test", 05:53:14 INFO - "buildnumber": 1522, 05:53:14 INFO - "slavename": "talos-linux64-ix-059", 05:53:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:53:14 INFO - "platform": "ubuntu64_hw", 05:53:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:53:14 INFO - "branch": "fx-team", 05:53:14 INFO - "repo_path": "integration/fx-team", 05:53:14 INFO - "revision": "d2d93c1d2ee32c4045ad623a794071d6bf78ea79", 05:53:14 INFO - "stage_platform": "linux64", 05:53:14 INFO - "builduid": "801a43ad9cfd476d8596f286d402e717", 05:53:14 INFO - "slavebuilddir": "test" 05:53:14 INFO - } 05:53:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:53:14 INFO - Running post-action listener: _resource_record_post_action 05:53:14 INFO - ##### 05:53:14 INFO - ##### Running download-and-extract step. 05:53:14 INFO - ##### 05:53:14 INFO - Running pre-action listener: _resource_record_pre_action 05:53:14 INFO - Running main action method: download_and_extract 05:53:14 INFO - mkdir: /builds/slave/test/build/tests 05:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:14 INFO - https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:15 INFO - Downloaded 1361 bytes. 05:53:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:53:15 INFO - Using the following test package requirements: 05:53:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:53:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'jsshell-linux-x86_64.zip'], 05:53:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:15 INFO - https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:17 INFO - Downloaded 22112056 bytes. 05:53:17 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'] 05:53:17 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 05:53:18 INFO - Return code: 0 05:53:18 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 05:53: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')]} 05:53:18 INFO - https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:20 INFO - Downloaded 22112056 bytes. 05:53:20 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'] 05:53:20 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 05:53:21 INFO - Return code: 0 05:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:21 INFO - https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:23 INFO - Downloaded 10847534 bytes. 05:53:23 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'] 05:53:23 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 05:53:23 INFO - Return code: 0 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:23 INFO - https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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 05:53:26 INFO - Downloaded 54218330 bytes. 05:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:53:26 INFO - mkdir: /builds/slave/test/properties 05:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:26 INFO - Contents: 05:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:53:26 INFO - Running post-action listener: _resource_record_post_action 05:53:26 INFO - Running post-action listener: set_extra_try_arguments 05:53:26 INFO - ##### 05:53:26 INFO - ##### Running populate-webroot step. 05:53:26 INFO - ##### 05:53:26 INFO - Running pre-action listener: _resource_record_pre_action 05:53:26 INFO - Running main action method: populate_webroot 05:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:26 INFO - '--tppagecycles', 05:53:26 INFO - '7'], 05:53:26 INFO - 'tests': ['tsvgm']}}, 05:53:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:53:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:53:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'tests': ['damp', 'tps']}, 05:53:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['damp', 'tps']}, 05:53:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:53:26 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['dromaeo_dom']}, 05:53:26 INFO - 'other': {'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'other_l64': {'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'other_nol64': {'tests': ['a11yr', 05:53:26 INFO - 'ts_paint', 05:53:26 INFO - 'tpaint', 05:53:26 INFO - 'sessionrestore', 05:53:26 INFO - 'sessionrestore_no_auto_restore', 05:53:26 INFO - 'tabpaint']}, 05:53:26 INFO - 'svgr': {'tests': ['tsvgx', 05:53:26 INFO - 'tsvgr_opacity', 05:53:26 INFO - 'tart', 05:53:26 INFO - 'tscrollx', 05:53:26 INFO - 'cart']}, 05:53:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['tsvgx', 05:53:26 INFO - 'tsvgr_opacity', 05:53:26 INFO - 'tart', 05:53:26 INFO - 'tscrollx', 05:53:26 INFO - 'cart']}, 05:53:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'tests': ['tp5o']}, 05:53:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'talos_options': ['--e10s'], 05:53:26 INFO - 'tests': ['tp5o']}, 05:53:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'talos_options': ['--xperf_path', 05:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:26 INFO - 'tests': ['tp5n']}, 05:53:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:26 INFO - 'talos_options': ['--e10s', 05:53:26 INFO - '--xperf_path', 05:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:26 INFO - 'tests': ['tp5n']}}, 05:53:26 INFO - 'talos.zip': {'path': '', 05:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:26 INFO - Running post-action listener: _resource_record_post_action 05:53:26 INFO - ##### 05:53:26 INFO - ##### Running create-virtualenv step. 05:53:26 INFO - ##### 05:53:26 INFO - Running pre-action listener: _resource_record_pre_action 05:53:26 INFO - Running main action method: create_virtualenv 05:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:27 INFO - Using real prefix '/usr' 05:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:29 INFO - Installing pip.................done. 05:53:29 INFO - Return code: 0 05:53:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:29 INFO - Using env: {'DISPLAY': ':0', 05:53:29 INFO - 'HOME': '/home/cltbld', 05:53:29 INFO - 'LANG': 'en_US.UTF-8', 05:53:29 INFO - 'LANGUAGE': 'en_US:en', 05:53:29 INFO - 'LOGNAME': 'cltbld', 05:53:29 INFO - 'MAIL': '/var/mail/cltbld', 05:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:29 INFO - 'MOZ_NO_REMOTE': '1', 05:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:29 INFO - 'NO_EM_RESTART': '1', 05:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:29 INFO - 'PWD': '/builds/slave/test', 05:53:29 INFO - 'SHELL': '/bin/bash', 05:53:29 INFO - 'SHLVL': '1', 05:53:29 INFO - 'TERM': 'linux', 05:53:29 INFO - 'TMOUT': '86400', 05:53:29 INFO - 'USER': 'cltbld', 05:53:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:29 INFO - '_': '/tools/buildbot/bin/python'} 05:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:53:29 INFO - Cleaning up... 05:53:29 INFO - Return code: 0 05:53:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:29 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 05:53:29 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 05:53:29 INFO - Using env: {'DISPLAY': ':0', 05:53:29 INFO - 'HOME': '/home/cltbld', 05:53:29 INFO - 'LANG': 'en_US.UTF-8', 05:53:29 INFO - 'LANGUAGE': 'en_US:en', 05:53:29 INFO - 'LOGNAME': 'cltbld', 05:53:29 INFO - 'MAIL': '/var/mail/cltbld', 05:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:29 INFO - 'MOZ_NO_REMOTE': '1', 05:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:29 INFO - 'NO_EM_RESTART': '1', 05:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:29 INFO - 'PWD': '/builds/slave/test', 05:53:29 INFO - 'SHELL': '/bin/bash', 05:53:29 INFO - 'SHLVL': '1', 05:53:29 INFO - 'TERM': 'linux', 05:53:29 INFO - 'TMOUT': '86400', 05:53:29 INFO - 'USER': 'cltbld', 05:53:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:29 INFO - '_': '/tools/buildbot/bin/python'} 05:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:29 INFO - Downloading/unpacking psutil>=0.7.1 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:31 INFO - Installing collected packages: psutil 05:53:31 INFO - Running setup.py install for psutil 05:53:32 INFO - building 'psutil._psutil_linux' extension 05:53:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:53:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:53:32 INFO - building 'psutil._psutil_posix' extension 05:53:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:53:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:32 INFO - Successfully installed psutil 05:53:32 INFO - Cleaning up... 05:53:32 INFO - Return code: 0 05:53:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:32 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 05:53:32 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 05:53:32 INFO - Using env: {'DISPLAY': ':0', 05:53:32 INFO - 'HOME': '/home/cltbld', 05:53:32 INFO - 'LANG': 'en_US.UTF-8', 05:53:32 INFO - 'LANGUAGE': 'en_US:en', 05:53:32 INFO - 'LOGNAME': 'cltbld', 05:53:32 INFO - 'MAIL': '/var/mail/cltbld', 05:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:32 INFO - 'MOZ_NO_REMOTE': '1', 05:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:32 INFO - 'NO_EM_RESTART': '1', 05:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:32 INFO - 'PWD': '/builds/slave/test', 05:53:32 INFO - 'SHELL': '/bin/bash', 05:53:32 INFO - 'SHLVL': '1', 05:53:32 INFO - 'TERM': 'linux', 05:53:32 INFO - 'TMOUT': '86400', 05:53:32 INFO - 'USER': 'cltbld', 05:53:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:32 INFO - '_': '/tools/buildbot/bin/python'} 05:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:53:34 INFO - Installing collected packages: mozsystemmonitor 05:53:34 INFO - Running setup.py install for mozsystemmonitor 05:53:34 INFO - Successfully installed mozsystemmonitor 05:53:34 INFO - Cleaning up... 05:53:34 INFO - Return code: 0 05:53:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:34 INFO - Using env: {'DISPLAY': ':0', 05:53:34 INFO - 'HOME': '/home/cltbld', 05:53:34 INFO - 'LANG': 'en_US.UTF-8', 05:53:34 INFO - 'LANGUAGE': 'en_US:en', 05:53:34 INFO - 'LOGNAME': 'cltbld', 05:53:34 INFO - 'MAIL': '/var/mail/cltbld', 05:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:34 INFO - 'MOZ_NO_REMOTE': '1', 05:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:34 INFO - 'NO_EM_RESTART': '1', 05:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:34 INFO - 'PWD': '/builds/slave/test', 05:53:34 INFO - 'SHELL': '/bin/bash', 05:53:34 INFO - 'SHLVL': '1', 05:53:34 INFO - 'TERM': 'linux', 05:53:34 INFO - 'TMOUT': '86400', 05:53:34 INFO - 'USER': 'cltbld', 05:53:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:34 INFO - '_': '/tools/buildbot/bin/python'} 05:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:37 INFO - Downloading docopt-0.6.1.tar.gz 05:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:37 INFO - Running setup.py install for blobuploader 05:53:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:37 INFO - Running setup.py install for requests 05:53:38 INFO - Running setup.py install for docopt 05:53:38 INFO - Successfully installed blobuploader requests docopt 05:53:38 INFO - Cleaning up... 05:53:38 INFO - Return code: 0 05:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53: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 05:53: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 05:53:38 INFO - Using env: {'DISPLAY': ':0', 05:53:38 INFO - 'HOME': '/home/cltbld', 05:53:38 INFO - 'LANG': 'en_US.UTF-8', 05:53:38 INFO - 'LANGUAGE': 'en_US:en', 05:53:38 INFO - 'LOGNAME': 'cltbld', 05:53:38 INFO - 'MAIL': '/var/mail/cltbld', 05:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:38 INFO - 'MOZ_NO_REMOTE': '1', 05:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:38 INFO - 'NO_EM_RESTART': '1', 05:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:38 INFO - 'PWD': '/builds/slave/test', 05:53:38 INFO - 'SHELL': '/bin/bash', 05:53:38 INFO - 'SHLVL': '1', 05:53:38 INFO - 'TERM': 'linux', 05:53:38 INFO - 'TMOUT': '86400', 05:53:38 INFO - 'USER': 'cltbld', 05:53:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:38 INFO - '_': '/tools/buildbot/bin/python'} 05:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:38 INFO - Running setup.py (path:/tmp/pip-KiQ4uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:38 INFO - Running setup.py (path:/tmp/pip-feUekt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:38 INFO - Running setup.py (path:/tmp/pip-aND5qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:38 INFO - Running setup.py (path:/tmp/pip-OhtS3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:38 INFO - Running setup.py (path:/tmp/pip-7nLrZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:38 INFO - Running setup.py (path:/tmp/pip-hHzpqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:38 INFO - Running setup.py (path:/tmp/pip-ZLr8qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:38 INFO - Running setup.py (path:/tmp/pip-87Ha03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:39 INFO - Running setup.py (path:/tmp/pip-SoM2ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:39 INFO - Running setup.py (path:/tmp/pip-28LhLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:39 INFO - Running setup.py (path:/tmp/pip-8HOl9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:39 INFO - Running setup.py (path:/tmp/pip-qi0XJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:39 INFO - Running setup.py (path:/tmp/pip-JwZ5im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:39 INFO - Running setup.py (path:/tmp/pip-luFAZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:39 INFO - Running setup.py (path:/tmp/pip-ey0mES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:39 INFO - Running setup.py (path:/tmp/pip-DLq58f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:39 INFO - Running setup.py (path:/tmp/pip-gDe3Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:39 INFO - Running setup.py install for manifestparser 05:53:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:39 INFO - Running setup.py install for mozcrash 05:53:39 INFO - Running setup.py install for mozdebug 05:53:39 INFO - Running setup.py install for mozdevice 05:53:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for mozfile 05:53:40 INFO - Running setup.py install for mozhttpd 05:53:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for mozinfo 05:53:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for mozInstall 05:53:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for mozleak 05:53:40 INFO - Running setup.py install for mozlog 05:53:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for moznetwork 05:53:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:40 INFO - Running setup.py install for mozprocess 05:53:40 INFO - Running setup.py install for mozprofile 05:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:41 INFO - Running setup.py install for mozrunner 05:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:41 INFO - Running setup.py install for mozscreenshot 05:53:41 INFO - Running setup.py install for moztest 05:53:41 INFO - Running setup.py install for mozversion 05:53:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:41 INFO - Cleaning up... 05:53:41 INFO - Return code: 0 05:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53: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 05:53: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 05:53:41 INFO - Using env: {'DISPLAY': ':0', 05:53:41 INFO - 'HOME': '/home/cltbld', 05:53:41 INFO - 'LANG': 'en_US.UTF-8', 05:53:41 INFO - 'LANGUAGE': 'en_US:en', 05:53:41 INFO - 'LOGNAME': 'cltbld', 05:53:41 INFO - 'MAIL': '/var/mail/cltbld', 05:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:41 INFO - 'MOZ_NO_REMOTE': '1', 05:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:41 INFO - 'NO_EM_RESTART': '1', 05:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:41 INFO - 'PWD': '/builds/slave/test', 05:53:41 INFO - 'SHELL': '/bin/bash', 05:53:41 INFO - 'SHLVL': '1', 05:53:41 INFO - 'TERM': 'linux', 05:53:41 INFO - 'TMOUT': '86400', 05:53:41 INFO - 'USER': 'cltbld', 05:53:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:41 INFO - '_': '/tools/buildbot/bin/python'} 05:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:41 INFO - Running setup.py (path:/tmp/pip-mlJ1YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53: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)) 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:41 INFO - Running setup.py (path:/tmp/pip-0t0d9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53: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)) 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:41 INFO - Running setup.py (path:/tmp/pip-VU9soC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53: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)) 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:41 INFO - Running setup.py (path:/tmp/pip-rbUkOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:41 INFO - Running setup.py (path:/tmp/pip-uWeS6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:42 INFO - Running setup.py (path:/tmp/pip-qIQdhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:42 INFO - Running setup.py (path:/tmp/pip-52UC_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:42 INFO - Running setup.py (path:/tmp/pip-2BsQB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:42 INFO - Running setup.py (path:/tmp/pip-5g1AxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:42 INFO - Running setup.py (path:/tmp/pip-FvXrFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:42 INFO - Running setup.py (path:/tmp/pip-Y2mmQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:42 INFO - Running setup.py (path:/tmp/pip-RYybNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:42 INFO - Running setup.py (path:/tmp/pip-pF0A1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:42 INFO - Running setup.py (path:/tmp/pip-uZ_TGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:42 INFO - Running setup.py (path:/tmp/pip-LjTTJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:42 INFO - Running setup.py (path:/tmp/pip-WRRjv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53: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)) 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:42 INFO - Running setup.py (path:/tmp/pip-Gz34nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:44 INFO - Downloading blessings-1.6.tar.gz 05:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:44 INFO - Installing collected packages: blessings 05:53:44 INFO - Running setup.py install for blessings 05:53:44 INFO - Successfully installed blessings 05:53:44 INFO - Cleaning up... 05:53:45 INFO - Return code: 0 05:53:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:45 INFO - Reading from file tmpfile_stdout 05:53:45 INFO - Current package versions: 05:53:45 INFO - argparse == 1.2.1 05:53:45 INFO - blessings == 1.6 05:53:45 INFO - blobuploader == 1.2.4 05:53:45 INFO - docopt == 0.6.1 05:53:45 INFO - manifestparser == 1.1 05:53:45 INFO - mozInstall == 1.12 05:53:45 INFO - mozcrash == 0.17 05:53:45 INFO - mozdebug == 0.1 05:53:45 INFO - mozdevice == 0.48 05:53:45 INFO - mozfile == 1.2 05:53:45 INFO - mozhttpd == 0.7 05:53:45 INFO - mozinfo == 0.9 05:53:45 INFO - mozleak == 0.1 05:53:45 INFO - mozlog == 3.1 05:53:45 INFO - moznetwork == 0.27 05:53:45 INFO - mozprocess == 0.22 05:53:45 INFO - mozprofile == 0.28 05:53:45 INFO - mozrunner == 6.11 05:53:45 INFO - mozscreenshot == 0.1 05:53:45 INFO - mozsystemmonitor == 0.0 05:53:45 INFO - moztest == 0.7 05:53:45 INFO - mozversion == 1.4 05:53:45 INFO - psutil == 3.1.1 05:53:45 INFO - requests == 1.2.3 05:53:45 INFO - wsgiref == 0.1.2 05:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53: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 05:53: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 05:53:45 INFO - Using env: {'DISPLAY': ':0', 05:53:45 INFO - 'HOME': '/home/cltbld', 05:53:45 INFO - 'LANG': 'en_US.UTF-8', 05:53:45 INFO - 'LANGUAGE': 'en_US:en', 05:53:45 INFO - 'LOGNAME': 'cltbld', 05:53:45 INFO - 'MAIL': '/var/mail/cltbld', 05:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:45 INFO - 'MOZ_NO_REMOTE': '1', 05:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:45 INFO - 'NO_EM_RESTART': '1', 05:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:45 INFO - 'PWD': '/builds/slave/test', 05:53:45 INFO - 'SHELL': '/bin/bash', 05:53:45 INFO - 'SHLVL': '1', 05:53:45 INFO - 'TERM': 'linux', 05:53:45 INFO - 'TMOUT': '86400', 05:53:45 INFO - 'USER': 'cltbld', 05:53:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:45 INFO - '_': '/tools/buildbot/bin/python'} 05:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53: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)) 05:53:45 INFO - Cleaning up... 05:53:45 INFO - Return code: 0 05:53:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53: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 05:53: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 05:53:45 INFO - Using env: {'DISPLAY': ':0', 05:53:45 INFO - 'HOME': '/home/cltbld', 05:53:45 INFO - 'LANG': 'en_US.UTF-8', 05:53:45 INFO - 'LANGUAGE': 'en_US:en', 05:53:45 INFO - 'LOGNAME': 'cltbld', 05:53:45 INFO - 'MAIL': '/var/mail/cltbld', 05:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:45 INFO - 'MOZ_NO_REMOTE': '1', 05:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:45 INFO - 'NO_EM_RESTART': '1', 05:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:45 INFO - 'PWD': '/builds/slave/test', 05:53:45 INFO - 'SHELL': '/bin/bash', 05:53:45 INFO - 'SHLVL': '1', 05:53:45 INFO - 'TERM': 'linux', 05:53:45 INFO - 'TMOUT': '86400', 05:53:45 INFO - 'USER': 'cltbld', 05:53:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:45 INFO - '_': '/tools/buildbot/bin/python'} 05:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:45 INFO - Downloading/unpacking jsonschema 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:47 INFO - warning: no files found matching '*.txt' 05:53:47 INFO - no previously-included directories found matching 'build' 05:53:47 INFO - no previously-included directories found matching 'dist' 05:53:47 INFO - no previously-included directories found matching '.git*' 05:53:47 INFO - Installing collected packages: jsonschema, functools32 05:53:47 INFO - Running setup.py install for functools32 05:53:47 INFO - warning: no files found matching '*.txt' 05:53:47 INFO - no previously-included directories found matching 'build' 05:53:47 INFO - no previously-included directories found matching 'dist' 05:53:47 INFO - no previously-included directories found matching '.git*' 05:53:47 INFO - Successfully installed jsonschema functools32 05:53:47 INFO - Cleaning up... 05:53:48 INFO - Return code: 0 05:53:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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 0x7f2063ea9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53: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 05:53: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 05:53:48 INFO - Using env: {'DISPLAY': ':0', 05:53:48 INFO - 'HOME': '/home/cltbld', 05:53:48 INFO - 'LANG': 'en_US.UTF-8', 05:53:48 INFO - 'LANGUAGE': 'en_US:en', 05:53:48 INFO - 'LOGNAME': 'cltbld', 05:53:48 INFO - 'MAIL': '/var/mail/cltbld', 05:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:48 INFO - 'MOZ_NO_REMOTE': '1', 05:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:48 INFO - 'NO_EM_RESTART': '1', 05:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:48 INFO - 'PWD': '/builds/slave/test', 05:53:48 INFO - 'SHELL': '/bin/bash', 05:53:48 INFO - 'SHLVL': '1', 05:53:48 INFO - 'TERM': 'linux', 05:53:48 INFO - 'TMOUT': '86400', 05:53:48 INFO - 'USER': 'cltbld', 05:53:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:48 INFO - '_': '/tools/buildbot/bin/python'} 05:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:48 INFO - Downloading/unpacking flake8 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:53:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:53:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:50 INFO - no previously-included directories found matching 'docs/_build' 05:53:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:53:50 INFO - Running setup.py install for pep8 05:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:50 INFO - no previously-included directories found matching 'docs/_build' 05:53:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:53:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:53:51 INFO - Cleaning up... 05:53:51 INFO - Return code: 0 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - Running post-action listener: _start_resource_monitoring 05:53:51 INFO - Starting resource monitoring. 05:53:51 INFO - ##### 05:53:51 INFO - ##### Running install step. 05:53:51 INFO - ##### 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: install 05:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:51 INFO - Reading from file tmpfile_stdout 05:53:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:51 INFO - Reading from file tmpfile_stdout 05:53:51 INFO - Output received: 05:53:51 INFO - Usage: mozinstall [options] installer 05:53:51 INFO - Options: 05:53:51 INFO - -h, --help show this help message and exit 05:53:51 INFO - -d DEST, --destination=DEST 05:53:51 INFO - Directory to install application into. [default: 05:53:51 INFO - "/builds/slave/test"] 05:53:51 INFO - --app=APP Application being installed. [default: firefox] 05:53:51 INFO - mkdir: /builds/slave/test/build/application 05:53: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'] 05:53: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 05:54:07 INFO - Reading from file tmpfile_stdout 05:54:07 INFO - Output received: 05:54:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:07 INFO - Running post-action listener: _resource_record_post_action 05:54:07 INFO - ##### 05:54:07 INFO - ##### Running run-tests step. 05:54:07 INFO - ##### 05:54:07 INFO - Running pre-action listener: _resource_record_pre_action 05:54:07 INFO - Running main action method: run_tests 05:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:07 INFO - Python 2.7.3 05:54:07 INFO - Return code: 0 05:54:07 INFO - grabbing minidump binary from tooltool 05:54: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')]} 05:54: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 0x29bb410>, '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 0x29bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54: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 05:54: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 05:54:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:07 INFO - Return code: 0 05:54:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:54:08 INFO - Return code: 0 05:54: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/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:54: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/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:54:08 INFO - Using env: {'DISPLAY': ':0', 05:54:08 INFO - 'HOME': '/home/cltbld', 05:54:08 INFO - 'LANG': 'en_US.UTF-8', 05:54:08 INFO - 'LANGUAGE': 'en_US:en', 05:54:08 INFO - 'LOGNAME': 'cltbld', 05:54:08 INFO - 'MAIL': '/var/mail/cltbld', 05:54:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:08 INFO - 'MOZ_NO_REMOTE': '1', 05:54:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:08 INFO - 'NO_EM_RESTART': '1', 05:54:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:08 INFO - 'PWD': '/builds/slave/test', 05:54:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:08 INFO - 'SHELL': '/bin/bash', 05:54:08 INFO - 'SHLVL': '1', 05:54:08 INFO - 'TERM': 'linux', 05:54:08 INFO - 'TMOUT': '86400', 05:54:08 INFO - 'USER': 'cltbld', 05:54:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971', 05:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:08 INFO - '_': '/tools/buildbot/bin/python'} 05:54: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/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:54:08 INFO - mozversion application_buildid: 20160401045338 05:54:08 INFO - mozversion application_changeset: d2d93c1d2ee32c4045ad623a794071d6bf78ea79 05:54:08 INFO - mozversion application_display_name: Nightly 05:54:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:08 INFO - mozversion application_name: Firefox 05:54:08 INFO - mozversion application_remotingname: firefox 05:54:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:54:08 INFO - mozversion application_vendor: Mozilla 05:54:08 INFO - mozversion application_version: 48.0a1 05:54:08 INFO - mozversion platform_buildid: 20160401045338 05:54:08 INFO - mozversion platform_changeset: d2d93c1d2ee32c4045ad623a794071d6bf78ea79 05:54:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:54:08 INFO - mozversion platform_version: 48.0a1 05:54:08 INFO - using testdate: 1459515248 05:54:08 INFO - actual date: 1459515248 05:54:08 INFO - starting webserver on 'localhost:56438' 05:54:08 INFO - SUITE-START | Running 2 tests 05:54:08 INFO - TEST-START | dromaeo_css 05:54:08 INFO - operating with platform_type : linux_ 05:54:08 INFO - Initialising browser for dromaeo_css test... 05:54:08 INFO - TEST-INFO | started process 31143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65rXsq/profile http://localhost:56438/getInfo.html) 05:54:12 INFO - PROCESS | 31143 | __metrics Screen width/height:1600/1200 05:54:12 INFO - PROCESS | 31143 | colorDepth:24 05:54:12 INFO - PROCESS | 31143 | Browser inner width/height: 1024/697 05:54:12 INFO - PROCESS | 31143 | __metrics 05:54:13 ERROR - PROCESS | 31143 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:54:14 INFO - TEST-INFO | 31143: exit 0 05:54:14 INFO - Browser initialized. 05:54:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:14 INFO - TEST-INFO | started process 31225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65rXsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:26 INFO - PROCESS | 31225 | RSS: Main: 154206208 05:54:26 INFO - PROCESS | 31225 | 05:55:17 INFO - PROCESS | 31225 | 1459515317070 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:57:30 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56438/tests/dromaeo/cssquery-ext.html) 05:57:31 INFO - PROCESS | 31225 | RSS: Main: 270270464 05:57:31 INFO - PROCESS | 31225 | 06:00:33 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-ext.html (next: http://localhost:56438/tests/dromaeo/cssquery-jquery.html) 06:00:34 INFO - PROCESS | 31225 | RSS: Main: 239669248 06:00:34 INFO - PROCESS | 31225 | 06:03:36 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56438/tests/dromaeo/cssquery-mootools.html) 06:03:36 INFO - PROCESS | 31225 | RSS: Main: 233021440 06:03:36 INFO - PROCESS | 31225 | 06:06:38 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56438/tests/dromaeo/cssquery-prototype.html) 06:06:39 INFO - PROCESS | 31225 | RSS: Main: 223240192 06:06:39 INFO - PROCESS | 31225 | 06:09:42 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56438/tests/dromaeo/cssquery-yui.html) 06:09:42 INFO - PROCESS | 31225 | RSS: Main: 206278656 06:09:42 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | Cycle 1(1): loaded http://localhost:56438/tests/dromaeo/cssquery-yui.html (next: http://localhost:56438/tests/dromaeo/cssquery-dojo.html) 06:12:45 INFO - PROCESS | 31225 | RSS: Main: 241504256 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | __start_tp_report 06:12:45 INFO - PROCESS | 31225 | _x_x_mozilla_page_load 06:12:45 INFO - PROCESS | 31225 | _x_x_mozilla_page_load_details 06:12:45 INFO - PROCESS | 31225 | |i|pagename|runs| 06:12:45 INFO - PROCESS | 31225 | |0;dojo.html;2670.626112344272;2767.197512721311;2773.597828314893;2785.3315204350947;2808.1996630960166;4624.514425985273;4728.858134255969;4786.066716990188;4786.54527819857;4790.9760451197735;4735.431748190222;4749.4775574686755;4778.139934811733;4845.830395936143;4851.830185943492;4304.031592891598;4322.07075478772;4350.651947844165;4364.825406983733;4464.441944756905;4414.139242847646;4414.668899832509;4430.556944305576;4480.260756975095;4482.731036137826;4271.807768650418;4291.527931927485;4364.498082720496;4371.060222052242;4388.626966707834;4400.1419723153995;4403.295472724349;4432.534583868712;4443.4445694288215;4456.8885777855485;4368.868933931955;4380.934285985712;4385.934210986838;4403.779811009436;4438.889027774331;4491.6855820092605;4578.450585929677;4599.83900563482;4637.536246375369;4672;5068.138416469209;5078.4413714491375;5079.060373830853;5083.593312534988;5111.258867464197;5092.770825312833;5096.3884333879805;5103.693778373272;5111.565516931066;5139.17773156297;4702.600278976325;4711.246200607955;4752.192127338395;4801.95198048022;4806.158922188603;5096.286519887219;5100.744962751847;5113.642045056885;5120.052790233819;5122.154844450624;4895.339129217581;4899.730514821647;4905.337779399807;4910.06708725341;4942.8517144485;4912.410510738663;4963.131451995959;5025.899482010413;5072.188449848007;5077.238414237894;4992;5047.066292735855;5052.621053420935;5054.393472783289;5101.8724531887;4939.580135688435;5007.023630392111;5020.297158397827;5022;5029.4719054498755;4259.361095835649;4261.446012018418;4271.466066741657;4326.091520780608;4412.4043254160915;3715.071232191952;3751.6998640109273;3757.7369584128846;3787.0910981364273;3790.9431358529646;4309.935350969738;4317.892052698645;4319.200947824663;4321.48142222929;4362.738235705868;4932.161532539477;5028.899422011539;5041.79832806691;5110.335656364723;5138.049460849755;4274.10243848789;4278.315469524923;4279.079997800488;4279.40088387626;4325.480942286946;4491.932621010687;4509.819607215674;4510.0979804039325;4513.540621865592;4530.954690453053;4596.2416201326405;4739.810407583658;4785.641076919314;4829;4830.420349558076;5011.4487406386;5022.271770593316;5024.397072351341;5037.269595908646;5084.41529224144;4724;4757.952420475889;4760.119377915097;4766.308885211694;4812.542808433333;4918.2376731606655;4958.727270000185;4962.6774259673;5004.274380214775;5016.724080175625;4966.850994470172;4968.354113965162;4981.551660350586;4982.875428114181;5029.974850125726;4730.314104454904;4854.95145048545;4861.927071094007;4892.046051020017;4911.435184953633;4914.140025495595;4936.654434189572;4938.876528086683;4941.184704523714;4995.750212489288;4843.709377437365;4863.367762191034;4866;4873.585745211555;4920.409550853778;4758.4765675776325;4866.099771542276;4954.256861470808;4961.355023846877;4995.075910956485;4742.478327383916;4786.95213047865;4788.138135135569;4816.518348165156;4912.361393018885 06:12:45 INFO - PROCESS | 31225 | |1;ext.html;518.5851318944844;522.6419902366879;532.1087178975213;534.663162207809;553.9806106786258;27266.454670906594;35201.82399088004;35702.821485892564;35922.820385898034;35959.280814383696;37894;38346;38358.424623630664;38389.616103838955;38441;7765.534067955927;7980.521168729866;7983.520988740665;7991.800204994893;7995.640196191185;7689.807754806118;7777.066751989769;7777.144514103473;7780.066392032964;7782.76651700447;7961.044674639023;8023.117457079746;8046.074701409325;8050.557219352933;8061.274485296322;7868.567228802413;7988.081370642392;8030.799230019296;8031.076426211002;8034.678612855479;7885.329746971514;7986.960065199695;8008.719694810712;8011.479253848481;8015.639296231683;38270;38562;38611.420828687595;38680.61319386827;38698;2865.426914617085;2869.971300286991;2955.866985985636;2961.392914452532;3142.3244002539564;29409.852950735323;29531.55702664462;29559;29569.112926612022;29866;3367.08334570503;3401.557797486311;3404;3414;3426.8286585670617;235830;236771;237387;238490;239650.99999999825;54724;54913.450865491635;54993;55016;55040.44959550433;63000.36999630037;63952;64132;64202.6789866057;64384;13351.198928064154;13477;13524.93237533806;13537.932310338581;13549.119307244997;10729.141668666489;10829.350238985686;10836.458177091114;10849.67450976472;10857.348559086322;19231.839135272658;20225.29211477591;20301;20320.28878989258;20365.389038328874;7144.642767861586;7160.606166660779;7330.486865919334;7459.776206713807;7569.243075692387;870.6734974384606;892.2103938014903;976.5654283843763;1013.6249587652616;1018.3686114608842;25506.362340941254;26196.083137090493;27048.864755676095;27049.45901081967;27121.457570848474;845.5138295480124;983.5868935047297;1041.463646222196;1054.225144518778;1054.7995880782628;12965.611031669065;13047.53959968228;13213.207207567577;13933.790993135111;14060.71878562423;283319;286182;286327;286853;287024;47963.520364795906;48492;48535.5146448531;48586.27120593194;48597.75701121543;1025.5333823110466;1184.603157942082;1220.0666490135054;1233.827264183033;1238.4612693478366;26256.34359141037;28040.85979570089;28604.570931435628;28617.856910715313;28718.569221461275;42203.36694949517;42880.14239715251;42944.85275736138;42980.785096074316;42991.57008430001;255984;261588;261787;261808;262212;27068;30930.226744331572;31259.687403125678;31348.68651313549;31367.05898823039;35917.82041089778;36942.445863311536;37182;37251.44122838214;37314.8134259327;31706.682933170374;31769;32819.67180328262;33533.664663353054;36083.27833443264;34137.82931085329;34246.828765857004;34737.82631086929;34958;35018.12454688653;34593.48109778405;34681.82659086688;34683;34717.65282347144;35301.29397412089;29806.25484362908;30863.69136308608;30936;31146;31154.221144470663;25002.62496062597;25046.3738406534;25048.499030019662;25255.74744252534;25313.114041009212 06:12:45 INFO - PROCESS | 31225 | |2;jquery.html;341.2918194745902;347.1148571143584;347.3417873130418;350.9403401421758;359.0538929919661;14830.629234269136;15255.694886102272;15871.682566348665;16427.67144657106;16550.50348489547;9889.653862114827;10260.333078349902;10271.691849244517;15531.922340388282;15774.526764197064;4612.607928326096;4745.074710431467;4749.548792864673;4755.524447555252;4768.189407800664;4465.129299786543;4552.954470455303;4562.041971186039;4677.976610116944;4727.125481785881;4524.140413321475;4543.840965566206;4552.635789136878;4555.544445555451;4559.384483094789;4581.793819278108;4633.050224703945;4636.884077898079;4639.327297541854;4643.558861908114;4517.073999830027;4609.861704148881;4632.166210082184;4639.211334073182;4642.257238841769;18928.337508187284;19082.23671053156;19451;19842.1071051803;19903.303384381623;1752.1677203328445;1856.5451464391176;1866.4214093631017;1880.6050729346853;1945.5136215946013;8778.385513014091;8998.14517620825;9147.313951453667;9194.35639505235;9362.859557106649;1544.5520798968398;1701.651161511887;1717.6307093974856;1726.205945265167;1775.4939842145056;42665.99999999969;52920;53677;53997.73001134969;59966.700166498886;8804.647814087364;9146.634134634673;9256.444613323221;9483.76290592727;9533;12972.481100755864;13031.08782385243;13033.283169425773;13043.347832608331;13087.41106650203;6883.346082122191;6932.23745388007;7044.049053377831;7047.647617619098;7053.753118640823;6502.512311576651;6543.44380727634;6584.473242140617;6636.933630663631;6663.333666633394;4228.746275223496;4290.099079193405;4298.914021719611;4302.333138363496;4379.3430985351815;1765.6821772080891;1793.4798908316443;1795.9820401796076;1860.144333606529;1876.07134468439;832.9666813327399;888.7156110044724;905.5200743605899;911.3620465674055;940.0787228516092;14152.43390264378;15539.689206215813;15654.9217253913;15769.763453548207;16308.429204978007;882.7395918204145;885.6811547842772;886.3529623374973;901.2740601747711;907.8048219632678;8405.327573794082;8533.615987280587;8725.171108744658;8746.081661425585;8755.824883502422;364456;383572;389705;392744;392962;71140;71705.2829471709;72314.63842680753;73337.26662733304;74480;912.4297314178639;937.1097457415483;961.9470929098967;978.2125389061873;995.6664517386756;13611.52359667407;13883.86116138866;13929.373178207208;13950.651233719238;14018.78971815444;30754.231144221572;31426.371472570878;31845.681543184273;32795;32918.67081329156;37630;38730.93325200813;40798.59201407948;40973;41205.58794412138;7012.894806578008;7254.310840470147;7323.084614423197;7362;7385.5937923412575;8560.957195213985;11245.943770281096;11417.143714221633;11555.711107222387;12222.816657750318;9920;10108.89891101109;10188.745281368025;10278.640247591298;10421.9478902605;9891.109800118023;10118.747031324276;10132.645357412455;10136.89863101389;10305.124064454305;10176.338537995007;10309.74225644365;10399.32404393712;10413.331609875606;10553.841692374466;7273.3817625500305;7332.156801967842;7387.926120738939;7548.4716069874585;7593.924060759322;10041.297109202285;10261.076503114755;10277.126444252322;10428.113610343205;10455.320404173704 06:12:45 INFO - PROCESS | 31225 | |3;mootools.html;1253.4735411127326;1375.8211432513772;1390.909590876593;1496.633324835415;1699.031552015351;6914.965425172873;7064.046353742243;7069.752558660448;7074.151101867777;7076.504644674875;6980.546264492805;7136.072310599628;7139.321764432384;7140.107486564179;7149.714011439536;1922.9423117306503;2144.2923835134447;2171.2400659769114;2195.5499122679894;2212;2201.3395981205654;2210.06072419222;2214.1586197245024;2224.5439684864564;2224.788645078723;2099.9790002099935;2171.3160354488286;2173.4892300309416;2174.4346469917855;2180.858244214121;2148.366231961575;2167.2631305356176;2183.290430610058;2227.855189412683;2236.2955668964223;2177.6080305544997;2200.8459407841456;2200.9779902200935;2202.812760915324;2203.449137715571;6971.268016858207;7059.117610298713;7066.540674856169;7073.292670732885;7082.752103676346;4196.454460920091;4224.852130175429;4265.786710664485;4283.378910058024;4287.48550173978;2818.506761316761;2885.466188755066;2903.41931613676;2910.592517047615;2932.604098446725;878.7012415778665;885.6147575804481;942.3168203052801;947.6493697331962;1686.4940517844598;9261.907380926172;9319.90680093197;9345.626174952993;9345.719628411158;9348.859767103499;3729.4405839124347;3890.7860067696547;3899.083715326896;3931.9017024574614;3954.367301231789;7581.772546823604;7632.045994250719;7657.578833164118;7665.041869766279;7668.846623067508;3877.515310586177;4225.408442818008;4259.8083086261195;4288.52826189119;4306;3997.2205419942834;4007.539132999684;4024.5170579530645;4043.8879308190485;4077.082656402345;3188.6651901550467;3276.836158192081;3276.983615081909;3282.2122690554097;3323.069540528656;991.4249735153738;997.8602995580625;998.9800203995879;999.0309399882103;1000.1099021870541;946.8958414574391;970.96601618943;1085.6200329884477;1170.5434880396651;1180.5631916191064;6592.373724496165;6713.2279787824045;6772.729090836311;6779.915213565806;6854.246032936373;457.3985209449563;461.5177139888824;464.5609898645747;465.42287563421115;472.92196787529673;4985.027919555652;5032.949670503322;5039.294498770102;5043.344365232496;5074.441811400743;8468.57657117154;8484.787880303042;8731.126887311219;8753.606087726068;8753.956230218935;8711.390202685878;8722.781930451789;8750.256228220673;8815.867761983576;8852.557372131369;6725.39471447572;6830.112085428863;6837.897431538531;6873.243943166148;6899.517033807686;6497.122888410004;6517.674116294261;6530.542861999615;6550.541462097607;6584.242812076673;7660.961695191489;7823.530588164728;7864.252895974873;7946.7615971520945;8077.515349079074;7964.800879978047;8147.429679922348;8180.222878826502;8252.422330436812;8327.292180164754;5332.73336333174;5704.973104841169;5954.910676339771;6053.576249662481;6058.636481811105;6670.166229221348;6700.664966751546;6716.361945615159;6725.39471447572;6739.359760822714;5985.940140598538;6074.3925607438905;6081.209442772411;6106.969465152646;6184.134221209124;5936.851578710567;6002.189704390026;6020.759169633341;6044.274687037584;6107.969460152671;6280.623162610258;6558.737650493927;6571.408573228432;6578.342165783575;6584.209894812653;5993.760249589967;6002.129691194665;6003.939960600338;6010.429009244115;6015.699215039143;6079.756809727562;6107.633541987495;6120.908186377297;6141.570090093651;6170.753169873155 06:12:45 INFO - PROCESS | 31225 | |4;prototype.html;317.83313760275854;320.67291362809937;321.9050380137858;326.9918252043697;328.38100181158524;5348.037353276409;5354.116570765824;5416.404195538493;5458.044842152617;5474.233607294982;5334.03987282289;5335.679859208451;5374.059539580568;5394.703291318976;5428.864278393033;3967.4643923070303;4062.309407400734;4218.578142185787;4230.302000169968;4234.87295381139;4180.937285940713;4213.915721685565;4217.8312867485265;4219.789010549475;4229.196452673982;3987.2224916141363;4145.523264824538;4173.290540608104;4180.331147016463;4180.916381672365;4061.8172182251724;4168.916081818749;4173.39485774564;4182.53992060873;4189.204051230272;3691.077230692327;3694.8891533254045;3695.1685870679153;3700.0749812546865;3704.2035962267973;5096.949030509684;5103.54068133866;5106.9489305106845;5108;5111.284420181178;4816.349792778;4833.226683730586;4834.734089625069;4835.1296766582;4840.322354870321;5655.660660360391;5656.8868622627315;5657.23627310312;5657.490825825655;5659.8585035374035;3817.0648191193336;4061.5938406159444;4063.6139566741113;4063.918721625551;4066.6136717011836;5892.705364731746;5945.970270148708;5962.612430192024;5968.641881487125;5970.432808883149;4047.8988025299013;4048.4534587830854;4049.149678567534;4052.392141178788;4057.107436363995;4102.589741025933;4106.589341065929;4107.9178416431505;4112.547619761824;4113.424120623115;4709.858704238878;4715.363425937455;4717.858464246078;4720.560229130079;4726.645501587394;5677.943220567824;5682.090865461506;5692.601517893708;5695.943040569541;5701.914471282934;1391.3391139208795;1426.7788492783636;1451.5645306408035;1451.9056261342978;1456.1627064437992;899.2221728205186;948.5968463403026;951.2580187453797;964.0359640359641;966.4829316315737;4884.65807393479;4913.582345500601;4915.26271059344;4916.8770780730765;4925.827596034122;5789.8263052108505;5799.797007104731;5802.564807639444;5803.65178089316;5820.126980952891;4905.043516514245;4906.043321552334;4910.852674419773;4911.435184953704;4914.311996320518;3088.474959256932;3128.687131286853;3129.5618613394145;3130.686931306851;3131.671174526642;5488.121900495981;5500.697461639648;5503.697296648643;5507.394186639466;5514.814314922311;5868.413158684098;6098.420650038239;6109.480694141048;6113.96943015291;6115.021596544531;5579.637323573955;5601.327840659065;5617.382087970238;5617.494425501724;5618.157276408571;5929.407059294036;5935.495482884004;5935.732892019956;5937.317208521075;5941.732622031933;5816.970915145397;5820.796272130455;5822.155787410717;5829;5830.212921255746;5366.275552800478;5607.467290607386;5610;5610.13042978339;5613.663180209201;4061.268971585143;4074.531428885716;4096.815643296119;4101.487314085739;4104.281750693676;5901.29184497863;5912.408759124053;5912.852178695567;5917.37867523921;5918.437748413894;5642.153676948491;5690.809038520282;5693.231413759255;5698.344690360662;5701.116326969326;5682.119271512922;5682.147677848356;5686.43135686428;5686.459786320293;5700.600957932905;5381.596380271417;5588.776448941997;5597.80407685729;5611.242482264842;5624.240727501735;5735.598508104559;5746.511546518593;5754.712264386848;5760.683162425939;5762.250907382014;5573.6098473106495;5611.270534830446;5625.971870140623;5629.971850140887;5632.211490391266 06:12:45 INFO - PROCESS | 31225 | |5;yui.html;660.6663634864394;712.4549719464608;733.3399940053949;743.609604957397;762.1349768013304;12377.876221237784;12545.121841471078;12583.182093163949;12584.811227831578;12599.748005039894;11990.16068875179;12053.15627906047;12053.517859285617;12979.545715899945;13200.075994680376;812.1999830167281;813.8982627171604;814.1166833985134;815.2581151152452;816.3428440105713;662.6123717625195;668.1447746883972;668.378408080485;670.5641333133453;826.7313123234943;694.7186389512256;843.2789964580287;863.5552690364467;867.1328671328671;868.2142660891903;845.9323254139684;845.9788505287355;846.4540371460373;846.8899043124385;847.9152084791533;502.3720349563046;623.9251289845248;624.7563450254404;626.2172284644195;627.8775638750445;9845.310828242025;9911.058449447291;11830.881691183064;11962.641120766391;11977.820332695017;11809.822852657217;11992.760144797143;12069.215500992408;12091.093168012347;12448.315342656151;9545.952270238673;9651.324407291493;9658.9517052415;9758.072983066597;9826.16477599405;3232.9838350808095;3276.836158192081;3278.377108349406;3345.1302661308237;3366.107981384935;43082.35376469324;43282.350764738556;43323.35014974778;43807.561924380665;44041.11917761627;9540.809183816285;9757.463339516395;9815.509224538744;9903.60385584583;9939.751506212402;16721.91639041797;16893.83106168947;16896;16899.577510562336;16962;6296.118543403927;6455.386738259858;6501.1548498694865;6520.4131628152745;6714.462842972551;3517.982410087933;3658.6707196352454;3685.1339935115225;3691.003429074135;3699.315626609086;2781.2907708534194;2790.776737860966;2797.804153709221;2799.4820958122814;2802.8038037337597;480.11418932070274;480.3251431738413;489.3003005701809;501.5435953282495;502.8541722900318;558.9245451864027;568.6275489554348;594.147398483178;607.0462848075287;620.7827260458894;7916.6437510311025;8046.195380461907;8248.381371397169;8336.916630833613;8620.310375169971;504.50306448148547;570.1181170320338;599.101347978033;611.2817439508649;634.9681767128417;3590.9102272443397;3825.2731980923536;3866.845326186977;3957.9010524737114;4007.719459637797;49681.75159124181;49811;50983.7450812751;51045;51207.23189152166;43988.3401748974;44641;44973.55026449759;45976.701164941616;46034.53965460369;37786;39536.604633953866;39555.01112472269;40212.39681404781;40324.79837600793;7559.244174798228;7797.805054873674;7978.601069946596;8021.318187953856;8079.878801818095;31284.687153128176;31571.36857262888;32083;32536;32676;36424.63575364213;36476;39755.2048959025;40134.1973160541;40463.393049103695;9207.953960230156;9213.769655758391;9411.858822117536;9414.858777118487;9472.100150485692;10374.844377334497;10408.115310198718;10578.735531611772;10742;10797;9942.701718948443;10059.647912323033;10135;10248.436336001592;10277.53751081218;9760.365576237522;9763.658271960447;9841.212702983887;9875.160611347828;9967.850482242628;10057.547410366406;10149.492525373555;10149.79700405973;10380.13956574016;10456.058954694114;8504.107068757692;8533.189347012023;8557.57212139403;8681.447837606487;8763.430377025474;8822.161894620001;8838;8862.778430539289;8863.512506812187;9130.36087473897 06:12:45 INFO - PROCESS | 31225 | __end_tp_report 06:12:45 INFO - PROCESS | 31225 | __start_cc_report 06:12:45 INFO - PROCESS | 31225 | _x_x_mozilla_cycle_collect,1081 06:12:45 INFO - PROCESS | 31225 | __end_cc_report 06:12:45 INFO - PROCESS | 31225 | __startTimestamp1459516365560__endTimestamp 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | ------- Summary: start ------- 06:12:45 INFO - PROCESS | 31225 | Number of tests: 6 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#0] dojo.html Cycles:165 Average:4667.64 Median:4790.98 stddev:464.65 (9.7%) stddev-sans-first:438.87 06:12:45 INFO - PROCESS | 31225 | Values: 2670.6 2767.2 2773.6 2785.3 2808.2 4624.5 4728.9 4786.1 4786.5 4791.0 4735.4 4749.5 4778.1 4845.8 4851.8 4304.0 4322.1 4350.7 4364.8 4464.4 4414.1 4414.7 4430.6 4480.3 4482.7 4271.8 4291.5 4364.5 4371.1 4388.6 4400.1 4403.3 4432.5 4443.4 4456.9 4368.9 4380.9 4385.9 4403.8 4438.9 4491.7 4578.5 4599.8 4637.5 4672.0 5068.1 5078.4 5079.1 5083.6 5111.3 5092.8 5096.4 5103.7 5111.6 5139.2 4702.6 4711.2 4752.2 4802.0 4806.2 5096.3 5100.7 5113.6 5120.1 5122.2 4895.3 4899.7 4905.3 4910.1 4942.9 4912.4 4963.1 5025.9 5072.2 5077.2 4992.0 5047.1 5052.6 5054.4 5101.9 4939.6 5007.0 5020.3 5022.0 5029.5 4259.4 4261.4 4271.5 4326.1 4412.4 3715.1 3751.7 3757.7 3787.1 3790.9 4309.9 4317.9 4319.2 4321.5 4362.7 4932.2 5028.9 5041.8 5110.3 5138.0 4274.1 4278.3 4279.1 4279.4 4325.5 4491.9 4509.8 4510.1 4513.5 4531.0 4596.2 4739.8 4785.6 4829.0 4830.4 5011.4 5022.3 5024.4 5037.3 5084.4 4724.0 4758.0 4760.1 4766.3 4812.5 4918.2 4958.7 4962.7 5004.3 5016.7 4966.9 4968.4 4981.6 4982.9 5030.0 4730.3 4855.0 4861.9 4892.0 4911.4 4914.1 4936.7 4938.9 4941.2 4995.8 4843.7 4863.4 4866.0 4873.6 4920.4 4758.5 4866.1 4954.3 4961.4 4995.1 4742.5 4787.0 4788.1 4816.5 4912.4 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#1] ext.html Cycles:180 Average:42504.51 Median:18836.83 stddev:68418.93 (363.2%) stddev-sans-first:68538.23 06:12:45 INFO - PROCESS | 31225 | Values: 518.6 522.6 532.1 534.7 554.0 27266.5 35201.8 35702.8 35922.8 35959.3 37894.0 38346.0 38358.4 38389.6 38441.0 7765.5 7980.5 7983.5 7991.8 7995.6 7689.8 7777.1 7777.1 7780.1 7782.8 7961.0 8023.1 8046.1 8050.6 8061.3 7868.6 7988.1 8030.8 8031.1 8034.7 7885.3 7987.0 8008.7 8011.5 8015.6 38270.0 38562.0 38611.4 38680.6 38698.0 2865.4 2870.0 2955.9 2961.4 3142.3 29409.9 29531.6 29559.0 29569.1 29866.0 3367.1 3401.6 3404.0 3414.0 3426.8 235830.0 236771.0 237387.0 238490.0 239651.0 54724.0 54913.5 54993.0 55016.0 55040.4 63000.4 63952.0 64132.0 64202.7 64384.0 13351.2 13477.0 13524.9 13537.9 13549.1 10729.1 10829.4 10836.5 10849.7 10857.3 19231.8 20225.3 20301.0 20320.3 20365.4 7144.6 7160.6 7330.5 7459.8 7569.2 870.7 892.2 976.6 1013.6 1018.4 25506.4 26196.1 27048.9 27049.5 27121.5 845.5 983.6 1041.5 1054.2 1054.8 12965.6 13047.5 13213.2 13933.8 14060.7 283319.0 286182.0 286327.0 286853.0 287024.0 47963.5 48492.0 48535.5 48586.3 48597.8 1025.5 1184.6 1220.1 1233.8 1238.5 26256.3 28040.9 28604.6 28617.9 28718.6 42203.4 42880.1 42944.9 42980.8 42991.6 255984.0 261588.0 261787.0 261808.0 262212.0 27068.0 30930.2 31259.7 31348.7 31367.1 35917.8 36942.4 37182.0 37251.4 37314.8 31706.7 31769.0 32819.7 33533.7 36083.3 34137.8 34246.8 34737.8 34958.0 35018.1 34593.5 34681.8 34683.0 34717.7 35301.3 29806.3 30863.7 30936.0 31146.0 31154.2 25002.6 25046.4 25048.5 25255.7 25313.1 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#2] jquery.html Cycles:180 Average:22633.31 Median:4340.84 stddev:63169.84 (1455.2%) stddev-sans-first:63324.87 06:12:45 INFO - PROCESS | 31225 | Values: 341.3 347.1 347.3 350.9 359.1 14830.6 15255.7 15871.7 16427.7 16550.5 9889.7 10260.3 10271.7 15531.9 15774.5 4612.6 4745.1 4749.5 4755.5 4768.2 4465.1 4553.0 4562.0 4678.0 4727.1 4524.1 4543.8 4552.6 4555.5 4559.4 4581.8 4633.1 4636.9 4639.3 4643.6 4517.1 4609.9 4632.2 4639.2 4642.3 18928.3 19082.2 19451.0 19842.1 19903.3 1752.2 1856.5 1866.4 1880.6 1945.5 8778.4 8998.1 9147.3 9194.4 9362.9 1544.6 1701.7 1717.6 1726.2 1775.5 42666.0 52920.0 53677.0 53997.7 59966.7 8804.6 9146.6 9256.4 9483.8 9533.0 12972.5 13031.1 13033.3 13043.3 13087.4 6883.3 6932.2 7044.0 7047.6 7053.8 6502.5 6543.4 6584.5 6636.9 6663.3 4228.7 4290.1 4298.9 4302.3 4379.3 1765.7 1793.5 1796.0 1860.1 1876.1 833.0 888.7 905.5 911.4 940.1 14152.4 15539.7 15654.9 15769.8 16308.4 882.7 885.7 886.4 901.3 907.8 8405.3 8533.6 8725.2 8746.1 8755.8 364456.0 383572.0 389705.0 392744.0 392962.0 71140.0 71705.3 72314.6 73337.3 74480.0 912.4 937.1 961.9 978.2 995.7 13611.5 13883.9 13929.4 13950.7 14018.8 30754.2 31426.4 31845.7 32795.0 32918.7 37630.0 38730.9 40798.6 40973.0 41205.6 7012.9 7254.3 7323.1 7362.0 7385.6 8561.0 11245.9 11417.1 11555.7 12222.8 9920.0 10108.9 10188.7 10278.6 10421.9 9891.1 10118.7 10132.6 10136.9 10305.1 10176.3 10309.7 10399.3 10413.3 10553.8 7273.4 7332.2 7387.9 7548.5 7593.9 10041.3 10261.1 10277.1 10428.1 10455.3 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#3] mootools.html Cycles:180 Average:4958.50 Median:6077.07 stddev:2559.49 (42.1%) stddev-sans-first:2551.52 06:12:45 INFO - PROCESS | 31225 | Values: 1253.5 1375.8 1390.9 1496.6 1699.0 6915.0 7064.0 7069.8 7074.2 7076.5 6980.5 7136.1 7139.3 7140.1 7149.7 1922.9 2144.3 2171.2 2195.5 2212.0 2201.3 2210.1 2214.2 2224.5 2224.8 2100.0 2171.3 2173.5 2174.4 2180.9 2148.4 2167.3 2183.3 2227.9 2236.3 2177.6 2200.8 2201.0 2202.8 2203.4 6971.3 7059.1 7066.5 7073.3 7082.8 4196.5 4224.9 4265.8 4283.4 4287.5 2818.5 2885.5 2903.4 2910.6 2932.6 878.7 885.6 942.3 947.6 1686.5 9261.9 9319.9 9345.6 9345.7 9348.9 3729.4 3890.8 3899.1 3931.9 3954.4 7581.8 7632.0 7657.6 7665.0 7668.8 3877.5 4225.4 4259.8 4288.5 4306.0 3997.2 4007.5 4024.5 4043.9 4077.1 3188.7 3276.8 3277.0 3282.2 3323.1 991.4 997.9 999.0 999.0 1000.1 946.9 971.0 1085.6 1170.5 1180.6 6592.4 6713.2 6772.7 6779.9 6854.2 457.4 461.5 464.6 465.4 472.9 4985.0 5032.9 5039.3 5043.3 5074.4 8468.6 8484.8 8731.1 8753.6 8754.0 8711.4 8722.8 8750.3 8815.9 8852.6 6725.4 6830.1 6837.9 6873.2 6899.5 6497.1 6517.7 6530.5 6550.5 6584.2 7661.0 7823.5 7864.3 7946.8 8077.5 7964.8 8147.4 8180.2 8252.4 8327.3 5332.7 5705.0 5954.9 6053.6 6058.6 6670.2 6700.7 6716.4 6725.4 6739.4 5985.9 6074.4 6081.2 6107.0 6184.1 5936.9 6002.2 6020.8 6044.3 6108.0 6280.6 6558.7 6571.4 6578.3 6584.2 5993.8 6002.1 6003.9 6010.4 6015.7 6079.8 6107.6 6120.9 6141.6 6170.8 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#4] prototype.html Cycles:180 Average:4708.11 Median:5377.83 stddev:1389.30 (25.8%) stddev-sans-first:1353.56 06:12:45 INFO - PROCESS | 31225 | Values: 317.8 320.7 321.9 327.0 328.4 5348.0 5354.1 5416.4 5458.0 5474.2 5334.0 5335.7 5374.1 5394.7 5428.9 3967.5 4062.3 4218.6 4230.3 4234.9 4180.9 4213.9 4217.8 4219.8 4229.2 3987.2 4145.5 4173.3 4180.3 4180.9 4061.8 4168.9 4173.4 4182.5 4189.2 3691.1 3694.9 3695.2 3700.1 3704.2 5096.9 5103.5 5106.9 5108.0 5111.3 4816.3 4833.2 4834.7 4835.1 4840.3 5655.7 5656.9 5657.2 5657.5 5659.9 3817.1 4061.6 4063.6 4063.9 4066.6 5892.7 5946.0 5962.6 5968.6 5970.4 4047.9 4048.5 4049.1 4052.4 4057.1 4102.6 4106.6 4107.9 4112.5 4113.4 4709.9 4715.4 4717.9 4720.6 4726.6 5677.9 5682.1 5692.6 5695.9 5701.9 1391.3 1426.8 1451.6 1451.9 1456.2 899.2 948.6 951.3 964.0 966.5 4884.7 4913.6 4915.3 4916.9 4925.8 5789.8 5799.8 5802.6 5803.7 5820.1 4905.0 4906.0 4910.9 4911.4 4914.3 3088.5 3128.7 3129.6 3130.7 3131.7 5488.1 5500.7 5503.7 5507.4 5514.8 5868.4 6098.4 6109.5 6114.0 6115.0 5579.6 5601.3 5617.4 5617.5 5618.2 5929.4 5935.5 5935.7 5937.3 5941.7 5817.0 5820.8 5822.2 5829.0 5830.2 5366.3 5607.5 5610.0 5610.1 5613.7 4061.3 4074.5 4096.8 4101.5 4104.3 5901.3 5912.4 5912.9 5917.4 5918.4 5642.2 5690.8 5693.2 5698.3 5701.1 5682.1 5682.1 5686.4 5686.5 5700.6 5381.6 5588.8 5597.8 5611.2 5624.2 5735.6 5746.5 5754.7 5760.7 5762.3 5573.6 5611.3 5626.0 5630.0 5632.2 06:12:45 INFO - PROCESS | 31225 | 06:12:45 INFO - PROCESS | 31225 | [#5] yui.html Cycles:180 Average:12330.90 Median:25744.12 stddev:14015.61 (54.4%) stddev-sans-first:14027.52 06:12:45 INFO - PROCESS | 31225 | Values: 660.7 712.5 733.3 743.6 762.1 12377.9 12545.1 12583.2 12584.8 12599.7 11990.2 12053.2 12053.5 12979.5 13200.1 812.2 813.9 814.1 815.3 816.3 662.6 668.1 668.4 670.6 826.7 694.7 843.3 863.6 867.1 868.2 845.9 846.0 846.5 846.9 847.9 502.4 623.9 624.8 626.2 627.9 9845.3 9911.1 11830.9 11962.6 11977.8 11809.8 11992.8 12069.2 12091.1 12448.3 9546.0 9651.3 9659.0 9758.1 9826.2 3233.0 3276.8 3278.4 3345.1 3366.1 43082.4 43282.4 43323.4 43807.6 44041.1 9540.8 9757.5 9815.5 9903.6 9939.8 16721.9 16893.8 16896.0 16899.6 16962.0 6296.1 6455.4 6501.2 6520.4 6714.5 3518.0 3658.7 3685.1 3691.0 3699.3 2781.3 2790.8 2797.8 2799.5 2802.8 480.1 480.3 489.3 501.5 502.9 558.9 568.6 594.1 607.0 620.8 7916.6 8046.2 8248.4 8336.9 8620.3 504.5 570.1 599.1 611.3 635.0 3590.9 3825.3 3866.8 3957.9 4007.7 49681.8 49811.0 50983.7 51045.0 51207.2 43988.3 44641.0 44973.6 45976.7 46034.5 37786.0 39536.6 39555.0 40212.4 40324.8 7559.2 7797.8 7978.6 8021.3 8079.9 31284.7 31571.4 32083.0 32536.0 32676.0 36424.6 36476.0 39755.2 40134.2 40463.4 9208.0 9213.8 9411.9 9414.9 9472.1 10374.8 10408.1 10578.7 10742.0 10797.0 9942.7 10059.6 10135.0 10248.4 10277.5 9760.4 9763.7 9841.2 9875.2 9967.9 10057.5 10149.5 10149.8 10380.1 10456.1 8504.1 8533.2 8557.6 8681.4 8763.4 8822.2 8838.0 8862.8 8863.5 9130.4 06:12:45 INFO - PROCESS | 31225 | -------- Summary: end -------- 06:12:45 INFO - PROCESS | 31225 | 06:12:46 INFO - TEST-INFO | 31225: exit 0 06:12:46 INFO - TEST-OK | dromaeo_css | took 1117890ms 06:12:46 INFO - TEST-START | kraken 06:12:46 INFO - operating with platform_type : linux_ 06:12:46 INFO - Initialising browser for kraken test... 06:12:46 INFO - TEST-INFO | started process 31406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppGnSxk/profile http://localhost:56438/getInfo.html) 06:12:50 INFO - PROCESS | 31406 | __metrics Screen width/height:1600/1200 06:12:50 INFO - PROCESS | 31406 | colorDepth:24 06:12:50 INFO - PROCESS | 31406 | Browser inner width/height: 1024/697 06:12:50 INFO - PROCESS | 31406 | __metrics 06:12:51 ERROR - PROCESS | 31406 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:12:52 INFO - TEST-INFO | 31406: exit 0 06:12:52 INFO - Browser initialized. 06:12:52 INFO - Running cycle 1/1 for kraken test... 06:12:52 INFO - TEST-INFO | started process 31490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppGnSxk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:04 INFO - PROCESS | 31490 | RSS: Main: 154693632 06:13:04 INFO - PROCESS | 31490 | 06:13:06 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56438/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:07 INFO - PROCESS | 31490 | RSS: Main: 196911104 06:13:07 INFO - PROCESS | 31490 | 06:13:10 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56438/tests/kraken/driver.html?testName=audio-dft) 06:13:10 INFO - PROCESS | 31490 | RSS: Main: 186974208 06:13:10 INFO - PROCESS | 31490 | 06:13:13 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56438/tests/kraken/driver.html?testName=audio-fft) 06:13:14 INFO - PROCESS | 31490 | RSS: Main: 170274816 06:13:14 INFO - PROCESS | 31490 | 06:13:16 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56438/tests/kraken/driver.html?testName=audio-oscillator) 06:13:16 INFO - PROCESS | 31490 | RSS: Main: 172228608 06:13:16 INFO - PROCESS | 31490 | 06:13:19 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:19 INFO - PROCESS | 31490 | RSS: Main: 173481984 06:13:19 INFO - PROCESS | 31490 | 06:13:22 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56438/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:23 INFO - PROCESS | 31490 | RSS: Main: 173608960 06:13:23 INFO - PROCESS | 31490 | 06:13:26 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56438/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:27 INFO - PROCESS | 31490 | RSS: Main: 171945984 06:13:27 INFO - PROCESS | 31490 | 06:13:30 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56438/tests/kraken/driver.html?testName=json-parse-financial) 06:13:31 INFO - PROCESS | 31490 | RSS: Main: 172736512 06:13:31 INFO - PROCESS | 31490 | 06:13:32 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:33 INFO - PROCESS | 31490 | RSS: Main: 184131584 06:13:33 INFO - PROCESS | 31490 | 06:13:35 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:35 INFO - PROCESS | 31490 | RSS: Main: 183050240 06:13:35 INFO - PROCESS | 31490 | 06:13:37 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:38 INFO - PROCESS | 31490 | RSS: Main: 194314240 06:13:38 INFO - PROCESS | 31490 | 06:13:40 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:41 INFO - PROCESS | 31490 | RSS: Main: 198602752 06:13:41 INFO - PROCESS | 31490 | 06:13:44 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:44 INFO - PROCESS | 31490 | RSS: Main: 197910528 06:13:44 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | Cycle 1(1): loaded http://localhost:56438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56438/tests/kraken/driver.html?testName=ai-astar) 06:13:46 INFO - PROCESS | 31490 | RSS: Main: 259555328 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | __start_tp_report 06:13:46 INFO - PROCESS | 31490 | _x_x_mozilla_page_load 06:13:46 INFO - PROCESS | 31490 | _x_x_mozilla_page_load_details 06:13:46 INFO - PROCESS | 31490 | |i|pagename|runs| 06:13:46 INFO - PROCESS | 31490 | |0;ai-astar;111;112;107;111;112;113;101;112;112;111 06:13:46 INFO - PROCESS | 31490 | |1;audio-beat-detection;164;132;164;170;135;158;163;133;182;131 06:13:46 INFO - PROCESS | 31490 | |2;audio-dft;162;161;162;162;161;159;161;161;162;161 06:13:46 INFO - PROCESS | 31490 | |3;audio-fft;78;74;103;103;73;73;74;112;94;77 06:13:46 INFO - PROCESS | 31490 | |4;audio-oscillator;94;95;138;94;94;94;144;94;94;144 06:13:46 INFO - PROCESS | 31490 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;117;117 06:13:46 INFO - PROCESS | 31490 | |6;imaging-darkroom;145;146;147;146;146;147;148;145;145;145 06:13:46 INFO - PROCESS | 31490 | |7;imaging-desaturate;95;96;95;95;95;94;95;96;96;95 06:13:46 INFO - PROCESS | 31490 | |8;json-parse-financial;64;74;64;64;63;65;64;74;62;63 06:13:46 INFO - PROCESS | 31490 | |9;json-stringify-tinderbox;64;63;63;63;63;64;63;63;64;64 06:13:46 INFO - PROCESS | 31490 | |10;stanford-crypto-aes;81;81;81;80;82;83;81;83;82;81 06:13:46 INFO - PROCESS | 31490 | |11;stanford-crypto-ccm;118;117;117;118;115;118;118;120;116;116 06:13:46 INFO - PROCESS | 31490 | |12;stanford-crypto-pbkdf2;137;133;139;142;143;129;142;148;145;147 06:13:46 INFO - PROCESS | 31490 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;66;67;76;68;67 06:13:46 INFO - PROCESS | 31490 | __end_tp_report 06:13:46 INFO - PROCESS | 31490 | __start_cc_report 06:13:46 INFO - PROCESS | 31490 | _x_x_mozilla_cycle_collect,1200 06:13:46 INFO - PROCESS | 31490 | __end_cc_report 06:13:46 INFO - PROCESS | 31490 | __startTimestamp1459516426693__endTimestamp 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | ------- Summary: start ------- 06:13:46 INFO - PROCESS | 31490 | Number of tests: 14 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.61 (3.2%) stddev-sans-first:3.82 06:13:46 INFO - PROCESS | 31490 | Values: 111.0 112.0 107.0 111.0 112.0 113.0 101.0 112.0 112.0 111.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:163.50 stddev:18.70 (11.4%) stddev-sans-first:19.42 06:13:46 INFO - PROCESS | 31490 | Values: 164.0 132.0 164.0 170.0 135.0 158.0 163.0 133.0 182.0 131.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:13:46 INFO - PROCESS | 31490 | Values: 162.0 161.0 162.0 162.0 161.0 159.0 161.0 161.0 162.0 161.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:15.23 (20.6%) stddev-sans-first:15.87 06:13:46 INFO - PROCESS | 31490 | Values: 78.0 74.0 103.0 103.0 73.0 73.0 74.0 112.0 94.0 77.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:94.00 stddev:23.18 (24.7%) stddev-sans-first:23.98 06:13:46 INFO - PROCESS | 31490 | Values: 94.0 95.0 138.0 94.0 94.0 94.0 144.0 94.0 94.0 144.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:13:46 INFO - PROCESS | 31490 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 06:13:46 INFO - PROCESS | 31490 | Values: 145.0 146.0 147.0 146.0 146.0 147.0 148.0 145.0 145.0 145.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:13:46 INFO - PROCESS | 31490 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 95.0 96.0 96.0 95.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:64.00 stddev:4.45 (7.0%) stddev-sans-first:4.68 06:13:46 INFO - PROCESS | 31490 | Values: 64.0 74.0 64.0 64.0 63.0 65.0 64.0 74.0 62.0 63.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:13:46 INFO - PROCESS | 31490 | Values: 64.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 06:13:46 INFO - PROCESS | 31490 | Values: 81.0 81.0 81.0 80.0 82.0 83.0 81.0 83.0 82.0 81.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.00 stddev:1.42 (1.2%) stddev-sans-first:1.48 06:13:46 INFO - PROCESS | 31490 | Values: 118.0 117.0 117.0 118.0 115.0 118.0 118.0 120.0 116.0 116.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.50 stddev:6.08 (4.3%) stddev-sans-first:6.31 06:13:46 INFO - PROCESS | 31490 | Values: 137.0 133.0 139.0 142.0 143.0 129.0 142.0 148.0 145.0 147.0 06:13:46 INFO - PROCESS | 31490 | 06:13:46 INFO - PROCESS | 31490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.97 (4.4%) stddev-sans-first:3.15 06:13:46 INFO - PROCESS | 31490 | Values: 68.0 66.0 67.0 67.0 66.0 66.0 67.0 76.0 68.0 67.0 06:13:46 INFO - PROCESS | 31490 | -------- Summary: end -------- 06:13:46 INFO - PROCESS | 31490 | 06:13:47 INFO - TEST-INFO | 31490: exit 0 06:13:47 INFO - TEST-OK | kraken | took 61510ms 06:13:47 INFO - SUITE-END | took 1179s 06:13:47 INFO - Completed test suite (00:19:39) 06:13:47 INFO - javascript benchmark 06:13:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2670.626112344272, 2767.197512721311, 2773.597828314893, 2785.3315204350947, 2808.1996630960166, 4624.514425985273, 4728.858134255969, 4786.066716990188, 4786.54527819857, 4790.9760451197735, 4735.431748190222, 4749.4775574686755, 4778.139934811733, 4845.830395936143, 4851.830185943492, 4304.031592891598, 4322.07075478772, 4350.651947844165, 4364.825406983733, 4464.441944756905, 4414.139242847646, 4414.668899832509, 4430.556944305576, 4480.260756975095, 4482.731036137826, 4271.807768650418, 4291.527931927485, 4364.498082720496, 4371.060222052242, 4388.626966707834, 4400.1419723153995, 4403.295472724349, 4432.534583868712, 4443.4445694288215, 4456.8885777855485, 4368.868933931955, 4380.934285985712, 4385.934210986838, 4403.779811009436, 4438.889027774331, 4491.6855820092605, 4578.450585929677, 4599.83900563482, 4637.536246375369, 4672.0, 5068.138416469209, 5078.4413714491375, 5079.060373830853, 5083.593312534988, 5111.258867464197, 5092.770825312833, 5096.3884333879805, 5103.693778373272, 5111.565516931066, 5139.17773156297, 4702.600278976325, 4711.246200607955, 4752.192127338395, 4801.95198048022, 4806.158922188603, 5096.286519887219, 5100.744962751847, 5113.642045056885, 5120.052790233819, 5122.154844450624, 4895.339129217581, 4899.730514821647, 4905.337779399807, 4910.06708725341, 4942.8517144485, 4912.410510738663, 4963.131451995959, 5025.899482010413, 5072.188449848007, 5077.238414237894, 4992.0, 5047.066292735855, 5052.621053420935, 5054.393472783289, 5101.8724531887, 4939.580135688435, 5007.023630392111, 5020.297158397827, 5022.0, 5029.4719054498755, 4259.361095835649, 4261.446012018418, 4271.466066741657, 4326.091520780608, 4412.4043254160915, 3715.071232191952, 3751.6998640109273, 3757.7369584128846, 3787.0910981364273, 3790.9431358529646, 4309.935350969738, 4317.892052698645, 4319.200947824663, 4321.48142222929, 4362.738235705868, 4932.161532539477, 5028.899422011539, 5041.79832806691, 5110.335656364723, 5138.049460849755, 4274.10243848789, 4278.315469524923, 4279.079997800488, 4279.40088387626, 4325.480942286946, 4491.932621010687, 4509.819607215674, 4510.0979804039325, 4513.540621865592, 4530.954690453053, 4596.2416201326405, 4739.810407583658, 4785.641076919314, 4829.0, 4830.420349558076, 5011.4487406386, 5022.271770593316, 5024.397072351341, 5037.269595908646, 5084.41529224144, 4724.0, 4757.952420475889, 4760.119377915097, 4766.308885211694, 4812.542808433333, 4918.2376731606655, 4958.727270000185, 4962.6774259673, 5004.274380214775, 5016.724080175625, 4966.850994470172, 4968.354113965162, 4981.551660350586, 4982.875428114181, 5029.974850125726, 4730.314104454904, 4854.95145048545, 4861.927071094007, 4892.046051020017, 4911.435184953633, 4914.140025495595, 4936.654434189572, 4938.876528086683, 4941.184704523714, 4995.750212489288, 4843.709377437365, 4863.367762191034, 4866.0, 4873.585745211555, 4920.409550853778, 4758.4765675776325, 4866.099771542276, 4954.256861470808, 4961.355023846877, 4995.075910956485, 4742.478327383916, 4786.95213047865, 4788.138135135569, 4816.518348165156, 4912.361393018885], "unit": "score", "name": "dojo.html", "value": 4640.008340499228}, {"lowerIsBetter": false, "replicates": [518.5851318944844, 522.6419902366879, 532.1087178975213, 534.663162207809, 553.9806106786258, 27266.454670906594, 35201.82399088004, 35702.821485892564, 35922.820385898034, 35959.280814383696, 37894.0, 38346.0, 38358.424623630664, 38389.616103838955, 38441.0, 7765.534067955927, 7980.521168729866, 7983.520988740665, 7991.800204994893, 7995.640196191185, 7689.807754806118, 7777.066751989769, 7777.144514103473, 7780.066392032964, 7782.76651700447, 7961.044674639023, 8023.117457079746, 8046.074701409325, 8050.557219352933, 8061.274485296322, 7868.567228802413, 7988.081370642392, 8030.799230019296, 8031.076426211002, 8034.678612855479, 7885.329746971514, 7986.960065199695, 8008.719694810712, 8011.479253848481, 8015.639296231683, 38270.0, 38562.0, 38611.420828687595, 38680.61319386827, 38698.0, 2865.426914617085, 2869.971300286991, 2955.866985985636, 2961.392914452532, 3142.3244002539564, 29409.852950735323, 29531.55702664462, 29559.0, 29569.112926612022, 29866.0, 3367.08334570503, 3401.557797486311, 3404.0, 3414.0, 3426.8286585670617, 235830.0, 236771.0, 237387.0, 238490.0, 239650.99999999825, 54724.0, 54913.450865491635, 54993.0, 55016.0, 55040.44959550433, 63000.36999630037, 63952.0, 64132.0, 64202.6789866057, 64384.0, 13351.198928064154, 13477.0, 13524.93237533806, 13537.932310338581, 13549.119307244997, 10729.141668666489, 10829.350238985686, 10836.458177091114, 10849.67450976472, 10857.348559086322, 19231.839135272658, 20225.29211477591, 20301.0, 20320.28878989258, 20365.389038328874, 7144.642767861586, 7160.606166660779, 7330.486865919334, 7459.776206713807, 7569.243075692387, 870.6734974384606, 892.2103938014903, 976.5654283843763, 1013.6249587652616, 1018.3686114608842, 25506.362340941254, 26196.083137090493, 27048.864755676095, 27049.45901081967, 27121.457570848474, 845.5138295480124, 983.5868935047297, 1041.463646222196, 1054.225144518778, 1054.7995880782628, 12965.611031669065, 13047.53959968228, 13213.207207567577, 13933.790993135111, 14060.71878562423, 283319.0, 286182.0, 286327.0, 286853.0, 287024.0, 47963.520364795906, 48492.0, 48535.5146448531, 48586.27120593194, 48597.75701121543, 1025.5333823110466, 1184.603157942082, 1220.0666490135054, 1233.827264183033, 1238.4612693478366, 26256.34359141037, 28040.85979570089, 28604.570931435628, 28617.856910715313, 28718.569221461275, 42203.36694949517, 42880.14239715251, 42944.85275736138, 42980.785096074316, 42991.57008430001, 255984.0, 261588.0, 261787.0, 261808.0, 262212.0, 27068.0, 30930.226744331572, 31259.687403125678, 31348.68651313549, 31367.05898823039, 35917.82041089778, 36942.445863311536, 37182.0, 37251.44122838214, 37314.8134259327, 31706.682933170374, 31769.0, 32819.67180328262, 33533.664663353054, 36083.27833443264, 34137.82931085329, 34246.828765857004, 34737.82631086929, 34958.0, 35018.12454688653, 34593.48109778405, 34681.82659086688, 34683.0, 34717.65282347144, 35301.29397412089, 29806.25484362908, 30863.69136308608, 30936.0, 31146.0, 31154.221144470663, 25002.62496062597, 25046.3738406534, 25048.499030019662, 25255.74744252534, 25313.114041009212], "unit": "score", "name": "ext.html", "value": 17153.61078977634}, {"lowerIsBetter": false, "replicates": [341.2918194745902, 347.1148571143584, 347.3417873130418, 350.9403401421758, 359.0538929919661, 14830.629234269136, 15255.694886102272, 15871.682566348665, 16427.67144657106, 16550.50348489547, 9889.653862114827, 10260.333078349902, 10271.691849244517, 15531.922340388282, 15774.526764197064, 4612.607928326096, 4745.074710431467, 4749.548792864673, 4755.524447555252, 4768.189407800664, 4465.129299786543, 4552.954470455303, 4562.041971186039, 4677.976610116944, 4727.125481785881, 4524.140413321475, 4543.840965566206, 4552.635789136878, 4555.544445555451, 4559.384483094789, 4581.793819278108, 4633.050224703945, 4636.884077898079, 4639.327297541854, 4643.558861908114, 4517.073999830027, 4609.861704148881, 4632.166210082184, 4639.211334073182, 4642.257238841769, 18928.337508187284, 19082.23671053156, 19451.0, 19842.1071051803, 19903.303384381623, 1752.1677203328445, 1856.5451464391176, 1866.4214093631017, 1880.6050729346853, 1945.5136215946013, 8778.385513014091, 8998.14517620825, 9147.313951453667, 9194.35639505235, 9362.859557106649, 1544.5520798968398, 1701.651161511887, 1717.6307093974856, 1726.205945265167, 1775.4939842145056, 42665.99999999969, 52920.0, 53677.0, 53997.73001134969, 59966.700166498886, 8804.647814087364, 9146.634134634673, 9256.444613323221, 9483.76290592727, 9533.0, 12972.481100755864, 13031.08782385243, 13033.283169425773, 13043.347832608331, 13087.41106650203, 6883.346082122191, 6932.23745388007, 7044.049053377831, 7047.647617619098, 7053.753118640823, 6502.512311576651, 6543.44380727634, 6584.473242140617, 6636.933630663631, 6663.333666633394, 4228.746275223496, 4290.099079193405, 4298.914021719611, 4302.333138363496, 4379.3430985351815, 1765.6821772080891, 1793.4798908316443, 1795.9820401796076, 1860.144333606529, 1876.07134468439, 832.9666813327399, 888.7156110044724, 905.5200743605899, 911.3620465674055, 940.0787228516092, 14152.43390264378, 15539.689206215813, 15654.9217253913, 15769.763453548207, 16308.429204978007, 882.7395918204145, 885.6811547842772, 886.3529623374973, 901.2740601747711, 907.8048219632678, 8405.327573794082, 8533.615987280587, 8725.171108744658, 8746.081661425585, 8755.824883502422, 364456.0, 383572.0, 389705.0, 392744.0, 392962.0, 71140.0, 71705.2829471709, 72314.63842680753, 73337.26662733304, 74480.0, 912.4297314178639, 937.1097457415483, 961.9470929098967, 978.2125389061873, 995.6664517386756, 13611.52359667407, 13883.86116138866, 13929.373178207208, 13950.651233719238, 14018.78971815444, 30754.231144221572, 31426.371472570878, 31845.681543184273, 32795.0, 32918.67081329156, 37630.0, 38730.93325200813, 40798.59201407948, 40973.0, 41205.58794412138, 7012.894806578008, 7254.310840470147, 7323.084614423197, 7362.0, 7385.5937923412575, 8560.957195213985, 11245.943770281096, 11417.143714221633, 11555.711107222387, 12222.816657750318, 9920.0, 10108.89891101109, 10188.745281368025, 10278.640247591298, 10421.9478902605, 9891.109800118023, 10118.747031324276, 10132.645357412455, 10136.89863101389, 10305.124064454305, 10176.338537995007, 10309.74225644365, 10399.32404393712, 10413.331609875606, 10553.841692374466, 7273.3817625500305, 7332.156801967842, 7387.926120738939, 7548.4716069874585, 7593.924060759322, 10041.297109202285, 10261.076503114755, 10277.126444252322, 10428.113610343205, 10455.320404173704], "unit": "score", "name": "jquery.html", "value": 7635.387639812033}, {"lowerIsBetter": false, "replicates": [1253.4735411127326, 1375.8211432513772, 1390.909590876593, 1496.633324835415, 1699.031552015351, 6914.965425172873, 7064.046353742243, 7069.752558660448, 7074.151101867777, 7076.504644674875, 6980.546264492805, 7136.072310599628, 7139.321764432384, 7140.107486564179, 7149.714011439536, 1922.9423117306503, 2144.2923835134447, 2171.2400659769114, 2195.5499122679894, 2212.0, 2201.3395981205654, 2210.06072419222, 2214.1586197245024, 2224.5439684864564, 2224.788645078723, 2099.9790002099935, 2171.3160354488286, 2173.4892300309416, 2174.4346469917855, 2180.858244214121, 2148.366231961575, 2167.2631305356176, 2183.290430610058, 2227.855189412683, 2236.2955668964223, 2177.6080305544997, 2200.8459407841456, 2200.9779902200935, 2202.812760915324, 2203.449137715571, 6971.268016858207, 7059.117610298713, 7066.540674856169, 7073.292670732885, 7082.752103676346, 4196.454460920091, 4224.852130175429, 4265.786710664485, 4283.378910058024, 4287.48550173978, 2818.506761316761, 2885.466188755066, 2903.41931613676, 2910.592517047615, 2932.604098446725, 878.7012415778665, 885.6147575804481, 942.3168203052801, 947.6493697331962, 1686.4940517844598, 9261.907380926172, 9319.90680093197, 9345.626174952993, 9345.719628411158, 9348.859767103499, 3729.4405839124347, 3890.7860067696547, 3899.083715326896, 3931.9017024574614, 3954.367301231789, 7581.772546823604, 7632.045994250719, 7657.578833164118, 7665.041869766279, 7668.846623067508, 3877.515310586177, 4225.408442818008, 4259.8083086261195, 4288.52826189119, 4306.0, 3997.2205419942834, 4007.539132999684, 4024.5170579530645, 4043.8879308190485, 4077.082656402345, 3188.6651901550467, 3276.836158192081, 3276.983615081909, 3282.2122690554097, 3323.069540528656, 991.4249735153738, 997.8602995580625, 998.9800203995879, 999.0309399882103, 1000.1099021870541, 946.8958414574391, 970.96601618943, 1085.6200329884477, 1170.5434880396651, 1180.5631916191064, 6592.373724496165, 6713.2279787824045, 6772.729090836311, 6779.915213565806, 6854.246032936373, 457.3985209449563, 461.5177139888824, 464.5609898645747, 465.42287563421115, 472.92196787529673, 4985.027919555652, 5032.949670503322, 5039.294498770102, 5043.344365232496, 5074.441811400743, 8468.57657117154, 8484.787880303042, 8731.126887311219, 8753.606087726068, 8753.956230218935, 8711.390202685878, 8722.781930451789, 8750.256228220673, 8815.867761983576, 8852.557372131369, 6725.39471447572, 6830.112085428863, 6837.897431538531, 6873.243943166148, 6899.517033807686, 6497.122888410004, 6517.674116294261, 6530.542861999615, 6550.541462097607, 6584.242812076673, 7660.961695191489, 7823.530588164728, 7864.252895974873, 7946.7615971520945, 8077.515349079074, 7964.800879978047, 8147.429679922348, 8180.222878826502, 8252.422330436812, 8327.292180164754, 5332.73336333174, 5704.973104841169, 5954.910676339771, 6053.576249662481, 6058.636481811105, 6670.166229221348, 6700.664966751546, 6716.361945615159, 6725.39471447572, 6739.359760822714, 5985.940140598538, 6074.3925607438905, 6081.209442772411, 6106.969465152646, 6184.134221209124, 5936.851578710567, 6002.189704390026, 6020.759169633341, 6044.274687037584, 6107.969460152671, 6280.623162610258, 6558.737650493927, 6571.408573228432, 6578.342165783575, 6584.209894812653, 5993.760249589967, 6002.129691194665, 6003.939960600338, 6010.429009244115, 6015.699215039143, 6079.756809727562, 6107.633541987495, 6120.908186377297, 6141.570090093651, 6170.753169873155], "unit": "score", "name": "mootools.html", "value": 4032.6196583251926}, {"lowerIsBetter": false, "replicates": [317.83313760275854, 320.67291362809937, 321.9050380137858, 326.9918252043697, 328.38100181158524, 5348.037353276409, 5354.116570765824, 5416.404195538493, 5458.044842152617, 5474.233607294982, 5334.03987282289, 5335.679859208451, 5374.059539580568, 5394.703291318976, 5428.864278393033, 3967.4643923070303, 4062.309407400734, 4218.578142185787, 4230.302000169968, 4234.87295381139, 4180.937285940713, 4213.915721685565, 4217.8312867485265, 4219.789010549475, 4229.196452673982, 3987.2224916141363, 4145.523264824538, 4173.290540608104, 4180.331147016463, 4180.916381672365, 4061.8172182251724, 4168.916081818749, 4173.39485774564, 4182.53992060873, 4189.204051230272, 3691.077230692327, 3694.8891533254045, 3695.1685870679153, 3700.0749812546865, 3704.2035962267973, 5096.949030509684, 5103.54068133866, 5106.9489305106845, 5108.0, 5111.284420181178, 4816.349792778, 4833.226683730586, 4834.734089625069, 4835.1296766582, 4840.322354870321, 5655.660660360391, 5656.8868622627315, 5657.23627310312, 5657.490825825655, 5659.8585035374035, 3817.0648191193336, 4061.5938406159444, 4063.6139566741113, 4063.918721625551, 4066.6136717011836, 5892.705364731746, 5945.970270148708, 5962.612430192024, 5968.641881487125, 5970.432808883149, 4047.8988025299013, 4048.4534587830854, 4049.149678567534, 4052.392141178788, 4057.107436363995, 4102.589741025933, 4106.589341065929, 4107.9178416431505, 4112.547619761824, 4113.424120623115, 4709.858704238878, 4715.363425937455, 4717.858464246078, 4720.560229130079, 4726.645501587394, 5677.943220567824, 5682.090865461506, 5692.601517893708, 5695.943040569541, 5701.914471282934, 1391.3391139208795, 1426.7788492783636, 1451.5645306408035, 1451.9056261342978, 1456.1627064437992, 899.2221728205186, 948.5968463403026, 951.2580187453797, 964.0359640359641, 966.4829316315737, 4884.65807393479, 4913.582345500601, 4915.26271059344, 4916.8770780730765, 4925.827596034122, 5789.8263052108505, 5799.797007104731, 5802.564807639444, 5803.65178089316, 5820.126980952891, 4905.043516514245, 4906.043321552334, 4910.852674419773, 4911.435184953704, 4914.311996320518, 3088.474959256932, 3128.687131286853, 3129.5618613394145, 3130.686931306851, 3131.671174526642, 5488.121900495981, 5500.697461639648, 5503.697296648643, 5507.394186639466, 5514.814314922311, 5868.413158684098, 6098.420650038239, 6109.480694141048, 6113.96943015291, 6115.021596544531, 5579.637323573955, 5601.327840659065, 5617.382087970238, 5617.494425501724, 5618.157276408571, 5929.407059294036, 5935.495482884004, 5935.732892019956, 5937.317208521075, 5941.732622031933, 5816.970915145397, 5820.796272130455, 5822.155787410717, 5829.0, 5830.212921255746, 5366.275552800478, 5607.467290607386, 5610.0, 5610.13042978339, 5613.663180209201, 4061.268971585143, 4074.531428885716, 4096.815643296119, 4101.487314085739, 4104.281750693676, 5901.29184497863, 5912.408759124053, 5912.852178695567, 5917.37867523921, 5918.437748413894, 5642.153676948491, 5690.809038520282, 5693.231413759255, 5698.344690360662, 5701.116326969326, 5682.119271512922, 5682.147677848356, 5686.43135686428, 5686.459786320293, 5700.600957932905, 5381.596380271417, 5588.776448941997, 5597.80407685729, 5611.242482264842, 5624.240727501735, 5735.598508104559, 5746.511546518593, 5754.712264386848, 5760.683162425939, 5762.250907382014, 5573.6098473106495, 5611.270534830446, 5625.971870140623, 5629.971850140887, 5632.211490391266], "unit": "score", "name": "prototype.html", "value": 4262.475618650817}, {"lowerIsBetter": false, "replicates": [660.6663634864394, 712.4549719464608, 733.3399940053949, 743.609604957397, 762.1349768013304, 12377.876221237784, 12545.121841471078, 12583.182093163949, 12584.811227831578, 12599.748005039894, 11990.16068875179, 12053.15627906047, 12053.517859285617, 12979.545715899945, 13200.075994680376, 812.1999830167281, 813.8982627171604, 814.1166833985134, 815.2581151152452, 816.3428440105713, 662.6123717625195, 668.1447746883972, 668.378408080485, 670.5641333133453, 826.7313123234943, 694.7186389512256, 843.2789964580287, 863.5552690364467, 867.1328671328671, 868.2142660891903, 845.9323254139684, 845.9788505287355, 846.4540371460373, 846.8899043124385, 847.9152084791533, 502.3720349563046, 623.9251289845248, 624.7563450254404, 626.2172284644195, 627.8775638750445, 9845.310828242025, 9911.058449447291, 11830.881691183064, 11962.641120766391, 11977.820332695017, 11809.822852657217, 11992.760144797143, 12069.215500992408, 12091.093168012347, 12448.315342656151, 9545.952270238673, 9651.324407291493, 9658.9517052415, 9758.072983066597, 9826.16477599405, 3232.9838350808095, 3276.836158192081, 3278.377108349406, 3345.1302661308237, 3366.107981384935, 43082.35376469324, 43282.350764738556, 43323.35014974778, 43807.561924380665, 44041.11917761627, 9540.809183816285, 9757.463339516395, 9815.509224538744, 9903.60385584583, 9939.751506212402, 16721.91639041797, 16893.83106168947, 16896.0, 16899.577510562336, 16962.0, 6296.118543403927, 6455.386738259858, 6501.1548498694865, 6520.4131628152745, 6714.462842972551, 3517.982410087933, 3658.6707196352454, 3685.1339935115225, 3691.003429074135, 3699.315626609086, 2781.2907708534194, 2790.776737860966, 2797.804153709221, 2799.4820958122814, 2802.8038037337597, 480.11418932070274, 480.3251431738413, 489.3003005701809, 501.5435953282495, 502.8541722900318, 558.9245451864027, 568.6275489554348, 594.147398483178, 607.0462848075287, 620.7827260458894, 7916.6437510311025, 8046.195380461907, 8248.381371397169, 8336.916630833613, 8620.310375169971, 504.50306448148547, 570.1181170320338, 599.101347978033, 611.2817439508649, 634.9681767128417, 3590.9102272443397, 3825.2731980923536, 3866.845326186977, 3957.9010524737114, 4007.719459637797, 49681.75159124181, 49811.0, 50983.7450812751, 51045.0, 51207.23189152166, 43988.3401748974, 44641.0, 44973.55026449759, 45976.701164941616, 46034.53965460369, 37786.0, 39536.604633953866, 39555.01112472269, 40212.39681404781, 40324.79837600793, 7559.244174798228, 7797.805054873674, 7978.601069946596, 8021.318187953856, 8079.878801818095, 31284.687153128176, 31571.36857262888, 32083.0, 32536.0, 32676.0, 36424.63575364213, 36476.0, 39755.2048959025, 40134.1973160541, 40463.393049103695, 9207.953960230156, 9213.769655758391, 9411.858822117536, 9414.858777118487, 9472.100150485692, 10374.844377334497, 10408.115310198718, 10578.735531611772, 10742.0, 10797.0, 9942.701718948443, 10059.647912323033, 10135.0, 10248.436336001592, 10277.53751081218, 9760.365576237522, 9763.658271960447, 9841.212702983887, 9875.160611347828, 9967.850482242628, 10057.547410366406, 10149.492525373555, 10149.79700405973, 10380.13956574016, 10456.058954694114, 8504.107068757692, 8533.189347012023, 8557.57212139403, 8681.447837606487, 8763.430377025474, 8822.161894620001, 8838.0, 8862.778430539289, 8863.512506812187, 9130.36087473897], "unit": "score", "name": "yui.html", "value": 5735.620546531559}], "name": "dromaeo_css", "value": 6255.517631495419}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 111.0, 112.0, 113.0, 101.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [164.0, 132.0, 164.0, 170.0, 135.0, 158.0, 163.0, 133.0, 182.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 153.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 159.0, 161.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 103.0, 103.0, 73.0, 73.0, 74.0, 112.0, 94.0, 77.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 94.0, 94.0, 94.0, 144.0, 94.0, 94.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [64.0, 74.0, 64.0, 64.0, 63.0, 65.0, 64.0, 74.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 80.0, 82.0, 83.0, 81.0, 83.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 115.0, 118.0, 118.0, 120.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [137.0, 133.0, 139.0, 142.0, 143.0, 129.0, 142.0, 148.0, 145.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 76.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1513.3}]} 06:13:47 INFO - Return code: 0 06:13:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:48 ERROR - # TBPL SUCCESS # 06:13:48 INFO - Running post-action listener: _resource_record_post_action 06:13:48 INFO - Running post-run listener: _resource_record_post_run 06:13:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527892480; Read time: 92; Write time: 500596 06:13:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240238592; Read time: 0; Write time: 295376 06:13:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287653888; Read time: 92; Write time: 205220 06:13:49 INFO - Running post-run listener: _upload_blobber_files 06:13:49 INFO - Blob upload gear active. 06:13:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:49 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 06:13:49 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'] 06:13:49 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 06:13:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:50 INFO - (blobuploader) - INFO - Done attempting. 06:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:51 INFO - (blobuploader) - INFO - Done attempting. 06:13:51 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:51 INFO - Return code: 0 06:13:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9eab8c3bd7c7b130c7c73b2ef3e758e95ac5f034edbe5d21cbb7b780a92deba177433eb4763229b2dfeea489d1b2da38cb55e73bbabba59fcf150acfa612c557", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72035a90c277ff6176b9ef2d2e50f1d93b72697acf75d3b724c9ff4470e528ecf5f7ef808b1ad69041b2aaf531aea42c6aa6be637113b323ac407aaea4fcad1"} 06:13:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:51 INFO - Contents: 06:13:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9eab8c3bd7c7b130c7c73b2ef3e758e95ac5f034edbe5d21cbb7b780a92deba177433eb4763229b2dfeea489d1b2da38cb55e73bbabba59fcf150acfa612c557", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72035a90c277ff6176b9ef2d2e50f1d93b72697acf75d3b724c9ff4470e528ecf5f7ef808b1ad69041b2aaf531aea42c6aa6be637113b323ac407aaea4fcad1"} 06:13:51 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:51 INFO - Copying logs to upload dir... 06:13:51 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.451042 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-01 06:13:48.358858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 06:13:48.362624) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 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/9eab8c3bd7c7b130c7c73b2ef3e758e95ac5f034edbe5d21cbb7b780a92deba177433eb4763229b2dfeea489d1b2da38cb55e73bbabba59fcf150acfa612c557", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72035a90c277ff6176b9ef2d2e50f1d93b72697acf75d3b724c9ff4470e528ecf5f7ef808b1ad69041b2aaf531aea42c6aa6be637113b323ac407aaea4fcad1"} build_url:https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/djhxN8MHR-2XTxzXHVwp-Q/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/9eab8c3bd7c7b130c7c73b2ef3e758e95ac5f034edbe5d21cbb7b780a92deba177433eb4763229b2dfeea489d1b2da38cb55e73bbabba59fcf150acfa612c557", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72035a90c277ff6176b9ef2d2e50f1d93b72697acf75d3b724c9ff4470e528ecf5f7ef808b1ad69041b2aaf531aea42c6aa6be637113b323ac407aaea4fcad1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 06:13:48.389439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 06:13:48.389763) ========= 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=3a3620fb28aea1604ab609ef000001d2-1459515010.161131-482422971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 06:13:48.474205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 06:13:48.474524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 06:13:48.474808) ========= ========= Total master_lag: 0.28 =========