builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1459737106.22 results: success (0) buildid: 20160403183818 builduid: 0370e4b7ad4243fd8473f907b22eef70 revision: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.220317) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.220818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.221177) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006228 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.300931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.301255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.461874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.462249) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027943 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.533687) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.533998) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.534421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.534764) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-03 19:31:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-04-03 19:31:46 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.772894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.773230) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.114187 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.900154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:46.900914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eaab4a3353618c192dbc9f3fa2ec3fc006034c30 --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 eaab4a3353618c192dbc9f3fa2ec3fc006034c30 --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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-03 19:31:47,128 truncating revision to first 12 chars 2016-04-03 19:31:47,128 Setting DEBUG logging. 2016-04-03 19:31:47,128 attempt 1/10 2016-04-03 19:31:47,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eaab4a335361?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 19:31:47,388 unpacking tar archive at: fx-team-eaab4a335361/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:47.467440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:47.467798) ========= echo eaab4a3353618c192dbc9f3fa2ec3fc006034c30 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eaab4a3353618c192dbc9f3fa2ec3fc006034c30'] 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False eaab4a3353618c192dbc9f3fa2ec3fc006034c30 program finished with exit code 0 elapsedTime=0.004099 script_repo_revision: 'eaab4a3353618c192dbc9f3fa2ec3fc006034c30' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:47.520201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:47.520532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 19:31:47.531539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-03 19:31:47.531914) ========= /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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:31:47 INFO - MultiFileLogger online at 20160403 19:31:47 in /builds/slave/test 19:31:47 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 19:31:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:31:47 INFO - {'append_to_log': False, 19:31:47 INFO - 'base_work_dir': '/builds/slave/test', 19:31:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:31:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:31:47 INFO - 'branch': 'Fx-Team-Non-PGO', 19:31:47 INFO - 'buildbot_json_path': 'buildprops.json', 19:31:47 INFO - 'config_files': ('talos/linux_config.py',), 19:31:47 INFO - 'default_actions': ('clobber', 19:31:47 INFO - 'read-buildbot-config', 19:31:47 INFO - 'download-and-extract', 19:31:47 INFO - 'populate-webroot', 19:31:47 INFO - 'create-virtualenv', 19:31:47 INFO - 'install', 19:31:47 INFO - 'run-tests'), 19:31:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:31:47 INFO - 'download_minidump_stackwalk': True, 19:31:47 INFO - 'download_symbols': 'ondemand', 19:31:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:31:47 INFO - 'tooltool.py': '/tools/tooltool.py', 19:31:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:31:47 INFO - '/tools/misc-python/virtualenv.py')}, 19:31:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:31:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:31:47 INFO - 'installer_path': 'installer.exe', 19:31:47 INFO - 'log_level': 'info', 19:31:47 INFO - 'log_name': 'talos', 19:31:47 INFO - 'log_to_console': True, 19:31:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:31:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:31:47 INFO - 'opt_config_files': (), 19:31:47 INFO - 'pip_index': False, 19:31:47 INFO - 'sps_profile': False, 19:31:47 INFO - 'sps_profile_interval': 0, 19:31:47 INFO - 'suite': 'dromaeojs', 19:31:47 INFO - 'system_bits': '32', 19:31:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:31:47 INFO - 'title': 'talos-linux64-ix-030', 19:31:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:31:47 INFO - 'use_talos_json': True, 19:31:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:31:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:31:47 INFO - 'work_dir': 'build'} 19:31:47 INFO - ##### 19:31:47 INFO - ##### Running clobber step. 19:31:47 INFO - ##### 19:31:47 INFO - Running pre-action listener: _resource_record_pre_action 19:31:47 INFO - Running main action method: clobber 19:31:47 INFO - rmtree: /builds/slave/test/build 19:31:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:31:48 INFO - Running post-action listener: _resource_record_post_action 19:31:48 INFO - ##### 19:31:48 INFO - ##### Running read-buildbot-config step. 19:31:48 INFO - ##### 19:31:48 INFO - Running pre-action listener: _resource_record_pre_action 19:31:48 INFO - Running main action method: read_buildbot_config 19:31:48 INFO - Using buildbot properties: 19:31:48 INFO - { 19:31:48 INFO - "project": "", 19:31:48 INFO - "product": "firefox", 19:31:48 INFO - "script_repo_revision": "production", 19:31:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:31:48 INFO - "repository": "", 19:31:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:31:48 INFO - "buildid": "20160403183818", 19:31:48 INFO - "pgo_build": "False", 19:31:48 INFO - "basedir": "/builds/slave/test", 19:31:48 INFO - "buildnumber": 1530, 19:31:48 INFO - "slavename": "talos-linux64-ix-030", 19:31:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:31:48 INFO - "platform": "ubuntu64_hw", 19:31:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:31:48 INFO - "branch": "fx-team", 19:31:48 INFO - "repo_path": "integration/fx-team", 19:31:48 INFO - "revision": "eaab4a3353618c192dbc9f3fa2ec3fc006034c30", 19:31:48 INFO - "stage_platform": "linux64", 19:31:48 INFO - "builduid": "0370e4b7ad4243fd8473f907b22eef70", 19:31:48 INFO - "slavebuilddir": "test" 19:31:48 INFO - } 19:31:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:31:48 INFO - Running post-action listener: _resource_record_post_action 19:31:48 INFO - ##### 19:31:48 INFO - ##### Running download-and-extract step. 19:31:48 INFO - ##### 19:31:48 INFO - Running pre-action listener: _resource_record_pre_action 19:31:48 INFO - Running main action method: download_and_extract 19:31:48 INFO - mkdir: /builds/slave/test/build/tests 19:31: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')]} 19:31:48 INFO - https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:31:55 INFO - Downloaded 1361 bytes. 19:31:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:31:55 INFO - Using the following test package requirements: 19:31:55 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:31:55 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:31:55 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:31:55 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'jsshell-linux-x86_64.zip'], 19:31:55 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:31:55 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:31:55 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:31:55 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:31:55 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:31:55 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:31:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:31:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:31:55 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')]} 19:31:55 INFO - https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:20 INFO - Downloaded 22125456 bytes. 19:32: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'] 19:32: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 19:32:21 INFO - Return code: 0 19:32:21 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 19:32: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')]} 19:32:21 INFO - https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:23 INFO - Downloaded 22125456 bytes. 19:32:23 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'] 19:32:23 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 19:32:24 INFO - Return code: 0 19:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:24 INFO - https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:32:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:26 INFO - Downloaded 10847584 bytes. 19:32:26 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'] 19:32:26 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 19:32:27 INFO - Return code: 0 19:32:27 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')]} 19:32:27 INFO - https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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 19:32:28 INFO - Downloaded 54089832 bytes. 19:32:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:32:28 INFO - mkdir: /builds/slave/test/properties 19:32:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:28 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:28 INFO - Contents: 19:32:28 INFO - build_url:https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:32:29 INFO - Running post-action listener: _resource_record_post_action 19:32:29 INFO - Running post-action listener: set_extra_try_arguments 19:32:29 INFO - ##### 19:32:29 INFO - ##### Running populate-webroot step. 19:32:29 INFO - ##### 19:32:29 INFO - Running pre-action listener: _resource_record_pre_action 19:32:29 INFO - Running main action method: populate_webroot 19:32:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:29 INFO - '--tppagecycles', 19:32:29 INFO - '7'], 19:32:29 INFO - 'tests': ['tsvgm']}}, 19:32:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:32:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:32:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:32:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'tests': ['damp', 'tps']}, 19:32:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['damp', 'tps']}, 19:32:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:32:29 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['dromaeo_dom']}, 19:32:29 INFO - 'other': {'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'other_l64': {'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'other_nol64': {'tests': ['a11yr', 19:32:29 INFO - 'ts_paint', 19:32:29 INFO - 'tpaint', 19:32:29 INFO - 'sessionrestore', 19:32:29 INFO - 'sessionrestore_no_auto_restore', 19:32:29 INFO - 'tabpaint']}, 19:32:29 INFO - 'svgr': {'tests': ['tsvgx', 19:32:29 INFO - 'tsvgr_opacity', 19:32:29 INFO - 'tart', 19:32:29 INFO - 'tscrollx', 19:32:29 INFO - 'cart']}, 19:32:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['tsvgx', 19:32:29 INFO - 'tsvgr_opacity', 19:32:29 INFO - 'tart', 19:32:29 INFO - 'tscrollx', 19:32:29 INFO - 'cart']}, 19:32:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'tests': ['tp5o']}, 19:32:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'talos_options': ['--e10s'], 19:32:29 INFO - 'tests': ['tp5o']}, 19:32:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'talos_options': ['--xperf_path', 19:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:29 INFO - 'tests': ['tp5n']}, 19:32:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:29 INFO - 'talos_options': ['--e10s', 19:32:29 INFO - '--xperf_path', 19:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:29 INFO - 'tests': ['tp5n']}}, 19:32:29 INFO - 'talos.zip': {'path': '', 19:32:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:29 INFO - Running post-action listener: _resource_record_post_action 19:32:29 INFO - ##### 19:32:29 INFO - ##### Running create-virtualenv step. 19:32:29 INFO - ##### 19:32:29 INFO - Running pre-action listener: _resource_record_pre_action 19:32:29 INFO - Running main action method: create_virtualenv 19:32:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:29 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 19:32:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:29 INFO - Using real prefix '/usr' 19:32:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:32 INFO - Installing pip.................done. 19:32:32 INFO - Return code: 0 19:32:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32: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', 'pip>=1.5'] in /builds/slave/test/build 19:32: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 pip>=1.5 19:32:32 INFO - Using env: {'DISPLAY': ':0', 19:32:32 INFO - 'HOME': '/home/cltbld', 19:32:32 INFO - 'LANG': 'en_US.UTF-8', 19:32:32 INFO - 'LANGUAGE': 'en_US:en', 19:32:32 INFO - 'LOGNAME': 'cltbld', 19:32:32 INFO - 'MAIL': '/var/mail/cltbld', 19:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:32 INFO - 'MOZ_NO_REMOTE': '1', 19:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:32 INFO - 'NO_EM_RESTART': '1', 19:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:32 INFO - 'PWD': '/builds/slave/test', 19:32:32 INFO - 'SHELL': '/bin/bash', 19:32:32 INFO - 'SHLVL': '1', 19:32:32 INFO - 'TERM': 'linux', 19:32:32 INFO - 'TMOUT': '86400', 19:32:32 INFO - 'USER': 'cltbld', 19:32:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:32 INFO - '_': '/tools/buildbot/bin/python'} 19:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:32 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 19:32:32 INFO - Cleaning up... 19:32:32 INFO - Return code: 0 19:32:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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', '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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32: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', 'psutil>=0.7.1'] in /builds/slave/test/build 19:32: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 psutil>=0.7.1 19:32:32 INFO - Using env: {'DISPLAY': ':0', 19:32:32 INFO - 'HOME': '/home/cltbld', 19:32:32 INFO - 'LANG': 'en_US.UTF-8', 19:32:32 INFO - 'LANGUAGE': 'en_US:en', 19:32:32 INFO - 'LOGNAME': 'cltbld', 19:32:32 INFO - 'MAIL': '/var/mail/cltbld', 19:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:32 INFO - 'MOZ_NO_REMOTE': '1', 19:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:32 INFO - 'NO_EM_RESTART': '1', 19:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:32 INFO - 'PWD': '/builds/slave/test', 19:32:32 INFO - 'SHELL': '/bin/bash', 19:32:32 INFO - 'SHLVL': '1', 19:32:32 INFO - 'TERM': 'linux', 19:32:32 INFO - 'TMOUT': '86400', 19:32:32 INFO - 'USER': 'cltbld', 19:32:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:32 INFO - '_': '/tools/buildbot/bin/python'} 19:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:33 INFO - Downloading/unpacking psutil>=0.7.1 19:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:35 INFO - Installing collected packages: psutil 19:32:35 INFO - Running setup.py install for psutil 19:32:35 INFO - building 'psutil._psutil_linux' extension 19:32:35 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 19:32:36 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 19:32:36 INFO - building 'psutil._psutil_posix' extension 19:32:36 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 19:32:36 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 19:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:36 INFO - Successfully installed psutil 19:32:36 INFO - Cleaning up... 19:32:36 INFO - Return code: 0 19:32:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:32:36 INFO - Using env: {'DISPLAY': ':0', 19:32:36 INFO - 'HOME': '/home/cltbld', 19:32:36 INFO - 'LANG': 'en_US.UTF-8', 19:32:36 INFO - 'LANGUAGE': 'en_US:en', 19:32:36 INFO - 'LOGNAME': 'cltbld', 19:32:36 INFO - 'MAIL': '/var/mail/cltbld', 19:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:36 INFO - 'MOZ_NO_REMOTE': '1', 19:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:36 INFO - 'NO_EM_RESTART': '1', 19:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:36 INFO - 'PWD': '/builds/slave/test', 19:32:36 INFO - 'SHELL': '/bin/bash', 19:32:36 INFO - 'SHLVL': '1', 19:32:36 INFO - 'TERM': 'linux', 19:32:36 INFO - 'TMOUT': '86400', 19:32:36 INFO - 'USER': 'cltbld', 19:32:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:36 INFO - '_': '/tools/buildbot/bin/python'} 19:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:32:38 INFO - Installing collected packages: mozsystemmonitor 19:32:38 INFO - Running setup.py install for mozsystemmonitor 19:32:39 INFO - Successfully installed mozsystemmonitor 19:32:39 INFO - Cleaning up... 19:32:39 INFO - Return code: 0 19:32:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:32:39 INFO - Using env: {'DISPLAY': ':0', 19:32:39 INFO - 'HOME': '/home/cltbld', 19:32:39 INFO - 'LANG': 'en_US.UTF-8', 19:32:39 INFO - 'LANGUAGE': 'en_US:en', 19:32:39 INFO - 'LOGNAME': 'cltbld', 19:32:39 INFO - 'MAIL': '/var/mail/cltbld', 19:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:39 INFO - 'MOZ_NO_REMOTE': '1', 19:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:39 INFO - 'NO_EM_RESTART': '1', 19:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:39 INFO - 'PWD': '/builds/slave/test', 19:32:39 INFO - 'SHELL': '/bin/bash', 19:32:39 INFO - 'SHLVL': '1', 19:32:39 INFO - 'TERM': 'linux', 19:32:39 INFO - 'TMOUT': '86400', 19:32:39 INFO - 'USER': 'cltbld', 19:32:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:39 INFO - '_': '/tools/buildbot/bin/python'} 19:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:39 INFO - Downloading/unpacking blobuploader==1.2.4 19:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:41 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:32:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:41 INFO - Downloading docopt-0.6.1.tar.gz 19:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:41 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:41 INFO - Running setup.py install for blobuploader 19:32:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:42 INFO - Running setup.py install for requests 19:32:42 INFO - Running setup.py install for docopt 19:32:42 INFO - Successfully installed blobuploader requests docopt 19:32:42 INFO - Cleaning up... 19:32:42 INFO - Return code: 0 19:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:42 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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:42 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 19:32:42 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 19:32:42 INFO - Using env: {'DISPLAY': ':0', 19:32:42 INFO - 'HOME': '/home/cltbld', 19:32:42 INFO - 'LANG': 'en_US.UTF-8', 19:32:42 INFO - 'LANGUAGE': 'en_US:en', 19:32:42 INFO - 'LOGNAME': 'cltbld', 19:32:42 INFO - 'MAIL': '/var/mail/cltbld', 19:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:42 INFO - 'MOZ_NO_REMOTE': '1', 19:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:42 INFO - 'NO_EM_RESTART': '1', 19:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:42 INFO - 'PWD': '/builds/slave/test', 19:32:42 INFO - 'SHELL': '/bin/bash', 19:32:42 INFO - 'SHLVL': '1', 19:32:42 INFO - 'TERM': 'linux', 19:32:42 INFO - 'TMOUT': '86400', 19:32:42 INFO - 'USER': 'cltbld', 19:32:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:42 INFO - '_': '/tools/buildbot/bin/python'} 19:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:42 INFO - Running setup.py (path:/tmp/pip-7PGpFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:42 INFO - Running setup.py (path:/tmp/pip-n_0IuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:42 INFO - Running setup.py (path:/tmp/pip-UGF5po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:42 INFO - Running setup.py (path:/tmp/pip-KKP9t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:43 INFO - Running setup.py (path:/tmp/pip-4hBTkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:43 INFO - Running setup.py (path:/tmp/pip-ajTUVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:43 INFO - Running setup.py (path:/tmp/pip-2EKKm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:43 INFO - Running setup.py (path:/tmp/pip-OBrRbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:43 INFO - Running setup.py (path:/tmp/pip-bi4LWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:43 INFO - Running setup.py (path:/tmp/pip-YnUG6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:43 INFO - Running setup.py (path:/tmp/pip-ibTlra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:43 INFO - Running setup.py (path:/tmp/pip-0EjWbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:43 INFO - Running setup.py (path:/tmp/pip-E5X3w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:43 INFO - Running setup.py (path:/tmp/pip-PHhLH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:43 INFO - Running setup.py (path:/tmp/pip-wNp4sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:43 INFO - Running setup.py (path:/tmp/pip-h_duNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:43 INFO - Running setup.py (path:/tmp/pip-NYooSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:43 INFO - Running setup.py install for manifestparser 19:32:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for mozcrash 19:32:44 INFO - Running setup.py install for mozdebug 19:32:44 INFO - Running setup.py install for mozdevice 19:32:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for mozfile 19:32:44 INFO - Running setup.py install for mozhttpd 19:32:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for mozinfo 19:32:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for mozInstall 19:32:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for mozleak 19:32:44 INFO - Running setup.py install for mozlog 19:32:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:44 INFO - Running setup.py install for moznetwork 19:32:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Running setup.py install for mozprocess 19:32:45 INFO - Running setup.py install for mozprofile 19:32:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Running setup.py install for mozrunner 19:32:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Running setup.py install for mozscreenshot 19:32:45 INFO - Running setup.py install for moztest 19:32:45 INFO - Running setup.py install for mozversion 19:32:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:45 INFO - Cleaning up... 19:32:45 INFO - Return code: 0 19:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:45 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 19:32:45 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 19:32:45 INFO - Using env: {'DISPLAY': ':0', 19:32:45 INFO - 'HOME': '/home/cltbld', 19:32:45 INFO - 'LANG': 'en_US.UTF-8', 19:32:45 INFO - 'LANGUAGE': 'en_US:en', 19:32:45 INFO - 'LOGNAME': 'cltbld', 19:32:45 INFO - 'MAIL': '/var/mail/cltbld', 19:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:45 INFO - 'MOZ_NO_REMOTE': '1', 19:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:45 INFO - 'NO_EM_RESTART': '1', 19:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:45 INFO - 'PWD': '/builds/slave/test', 19:32:45 INFO - 'SHELL': '/bin/bash', 19:32:45 INFO - 'SHLVL': '1', 19:32:45 INFO - 'TERM': 'linux', 19:32:45 INFO - 'TMOUT': '86400', 19:32:45 INFO - 'USER': 'cltbld', 19:32:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:45 INFO - '_': '/tools/buildbot/bin/python'} 19:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:45 INFO - Running setup.py (path:/tmp/pip-Gd4xVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:46 INFO - Running setup.py (path:/tmp/pip-WTR8zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:46 INFO - Running setup.py (path:/tmp/pip-pdGod9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:46 INFO - Running setup.py (path:/tmp/pip-h61vE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:46 INFO - Running setup.py (path:/tmp/pip-Zs5QFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:46 INFO - Running setup.py (path:/tmp/pip-ZDCkwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:46 INFO - Running setup.py (path:/tmp/pip-CEOjEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:46 INFO - Running setup.py (path:/tmp/pip-PO1PWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:46 INFO - Running setup.py (path:/tmp/pip-9sEhkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:46 INFO - Running setup.py (path:/tmp/pip-3N8ASj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:46 INFO - Running setup.py (path:/tmp/pip-UlBBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:46 INFO - Running setup.py (path:/tmp/pip-sMDugc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:46 INFO - Running setup.py (path:/tmp/pip-T_56qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:46 INFO - Running setup.py (path:/tmp/pip-xxXgH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:46 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)) 19:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:46 INFO - Running setup.py (path:/tmp/pip-czJM6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:47 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)) 19:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:47 INFO - Running setup.py (path:/tmp/pip-2d1KRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:47 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)) 19:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:47 INFO - Running setup.py (path:/tmp/pip-Zfsr9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:47 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)) 19:32:47 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)) 19:32:47 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)) 19:32:47 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)) 19:32:47 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)) 19:32:47 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)) 19:32:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32:49 INFO - Downloading blessings-1.6.tar.gz 19:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:49 INFO - Installing collected packages: blessings 19:32:49 INFO - Running setup.py install for blessings 19:32:49 INFO - Successfully installed blessings 19:32:49 INFO - Cleaning up... 19:32:49 INFO - Return code: 0 19:32:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:49 INFO - Reading from file tmpfile_stdout 19:32:49 INFO - Current package versions: 19:32:49 INFO - argparse == 1.2.1 19:32:49 INFO - blessings == 1.6 19:32:49 INFO - blobuploader == 1.2.4 19:32:49 INFO - docopt == 0.6.1 19:32:49 INFO - manifestparser == 1.1 19:32:49 INFO - mozInstall == 1.12 19:32:49 INFO - mozcrash == 0.17 19:32:49 INFO - mozdebug == 0.1 19:32:49 INFO - mozdevice == 0.48 19:32:49 INFO - mozfile == 1.2 19:32:49 INFO - mozhttpd == 0.7 19:32:49 INFO - mozinfo == 0.9 19:32:49 INFO - mozleak == 0.1 19:32:49 INFO - mozlog == 3.1 19:32:49 INFO - moznetwork == 0.27 19:32:49 INFO - mozprocess == 0.22 19:32:49 INFO - mozprofile == 0.28 19:32:49 INFO - mozrunner == 6.11 19:32:49 INFO - mozscreenshot == 0.1 19:32:49 INFO - mozsystemmonitor == 0.0 19:32:49 INFO - moztest == 0.7 19:32:49 INFO - mozversion == 1.4 19:32:49 INFO - psutil == 3.1.1 19:32:49 INFO - requests == 1.2.3 19:32:49 INFO - wsgiref == 0.1.2 19:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:49 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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:49 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 19:32:49 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 19:32:49 INFO - Using env: {'DISPLAY': ':0', 19:32:49 INFO - 'HOME': '/home/cltbld', 19:32:49 INFO - 'LANG': 'en_US.UTF-8', 19:32:49 INFO - 'LANGUAGE': 'en_US:en', 19:32:49 INFO - 'LOGNAME': 'cltbld', 19:32:49 INFO - 'MAIL': '/var/mail/cltbld', 19:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:49 INFO - 'MOZ_NO_REMOTE': '1', 19:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:49 INFO - 'NO_EM_RESTART': '1', 19:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:49 INFO - 'PWD': '/builds/slave/test', 19:32:49 INFO - 'SHELL': '/bin/bash', 19:32:49 INFO - 'SHLVL': '1', 19:32:49 INFO - 'TERM': 'linux', 19:32:49 INFO - 'TMOUT': '86400', 19:32:49 INFO - 'USER': 'cltbld', 19:32:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:49 INFO - '_': '/tools/buildbot/bin/python'} 19:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 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)) 19:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:32:49 INFO - Cleaning up... 19:32:49 INFO - Return code: 0 19:32:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:49 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 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:49 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 19:32:49 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 19:32:49 INFO - Using env: {'DISPLAY': ':0', 19:32:49 INFO - 'HOME': '/home/cltbld', 19:32:49 INFO - 'LANG': 'en_US.UTF-8', 19:32:49 INFO - 'LANGUAGE': 'en_US:en', 19:32:49 INFO - 'LOGNAME': 'cltbld', 19:32:49 INFO - 'MAIL': '/var/mail/cltbld', 19:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:49 INFO - 'MOZ_NO_REMOTE': '1', 19:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:49 INFO - 'NO_EM_RESTART': '1', 19:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:49 INFO - 'PWD': '/builds/slave/test', 19:32:49 INFO - 'SHELL': '/bin/bash', 19:32:49 INFO - 'SHLVL': '1', 19:32:49 INFO - 'TERM': 'linux', 19:32:49 INFO - 'TMOUT': '86400', 19:32:49 INFO - 'USER': 'cltbld', 19:32:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:49 INFO - '_': '/tools/buildbot/bin/python'} 19:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:49 INFO - Downloading/unpacking jsonschema 19:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:32:51 INFO - Downloading/unpacking functools32 (from jsonschema) 19:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:32:52 INFO - warning: no files found matching '*.txt' 19:32:52 INFO - no previously-included directories found matching 'build' 19:32:52 INFO - no previously-included directories found matching 'dist' 19:32:52 INFO - no previously-included directories found matching '.git*' 19:32:52 INFO - Installing collected packages: jsonschema, functools32 19:32:52 INFO - Running setup.py install for functools32 19:32:52 INFO - warning: no files found matching '*.txt' 19:32:52 INFO - no previously-included directories found matching 'build' 19:32:52 INFO - no previously-included directories found matching 'dist' 19:32:52 INFO - no previously-included directories found matching '.git*' 19:32:52 INFO - Successfully installed jsonschema functools32 19:32:52 INFO - Cleaning up... 19:32:52 INFO - Return code: 0 19:32:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3df4010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', '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 19:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:32:52 INFO - Using env: {'DISPLAY': ':0', 19:32:52 INFO - 'HOME': '/home/cltbld', 19:32:52 INFO - 'LANG': 'en_US.UTF-8', 19:32:52 INFO - 'LANGUAGE': 'en_US:en', 19:32:52 INFO - 'LOGNAME': 'cltbld', 19:32:52 INFO - 'MAIL': '/var/mail/cltbld', 19:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:52 INFO - 'MOZ_NO_REMOTE': '1', 19:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:52 INFO - 'NO_EM_RESTART': '1', 19:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:52 INFO - 'PWD': '/builds/slave/test', 19:32:52 INFO - 'SHELL': '/bin/bash', 19:32:52 INFO - 'SHLVL': '1', 19:32:52 INFO - 'TERM': 'linux', 19:32:52 INFO - 'TMOUT': '86400', 19:32:52 INFO - 'USER': 'cltbld', 19:32:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:52 INFO - '_': '/tools/buildbot/bin/python'} 19:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:52 INFO - Downloading/unpacking flake8 19:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:32:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:32:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:32:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:55 INFO - no previously-included directories found matching 'docs/_build' 19:32:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:32:55 INFO - Running setup.py install for pep8 19:32:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:55 INFO - no previously-included directories found matching 'docs/_build' 19:32:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:32:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:32:55 INFO - Cleaning up... 19:32:55 INFO - Return code: 0 19:32:55 INFO - Running post-action listener: _resource_record_post_action 19:32:55 INFO - Running post-action listener: _start_resource_monitoring 19:32:55 INFO - Starting resource monitoring. 19:32:55 INFO - ##### 19:32:55 INFO - ##### Running install step. 19:32:55 INFO - ##### 19:32:55 INFO - Running pre-action listener: _resource_record_pre_action 19:32:55 INFO - Running main action method: install 19:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:55 INFO - Reading from file tmpfile_stdout 19:32:55 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:55 INFO - Reading from file tmpfile_stdout 19:32:55 INFO - Output received: 19:32:55 INFO - Usage: mozinstall [options] installer 19:32:55 INFO - Options: 19:32:55 INFO - -h, --help show this help message and exit 19:32:55 INFO - -d DEST, --destination=DEST 19:32:55 INFO - Directory to install application into. [default: 19:32:55 INFO - "/builds/slave/test"] 19:32:55 INFO - --app=APP Application being installed. [default: firefox] 19:32:55 INFO - mkdir: /builds/slave/test/build/application 19:32:55 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'] 19:32:55 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 19:33:11 INFO - Reading from file tmpfile_stdout 19:33:11 INFO - Output received: 19:33:11 INFO - /builds/slave/test/build/application/firefox/firefox 19:33:11 INFO - Running post-action listener: _resource_record_post_action 19:33:11 INFO - ##### 19:33:11 INFO - ##### Running run-tests step. 19:33:11 INFO - ##### 19:33:11 INFO - Running pre-action listener: _resource_record_pre_action 19:33:11 INFO - Running main action method: run_tests 19:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:33:11 INFO - Python 2.7.3 19:33:11 INFO - Return code: 0 19:33:11 INFO - grabbing minidump binary from tooltool 19:33:11 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')]} 19:33:11 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 0x1638410>, '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 0x1639310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16397a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:33:11 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 19:33:11 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 19:33:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:33:11 INFO - Return code: 0 19:33:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:33:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:33:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:33:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:33:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:33:12 INFO - Return code: 0 19:33:12 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/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 19:33:12 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/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 19:33:12 INFO - Using env: {'DISPLAY': ':0', 19:33:12 INFO - 'HOME': '/home/cltbld', 19:33:12 INFO - 'LANG': 'en_US.UTF-8', 19:33:12 INFO - 'LANGUAGE': 'en_US:en', 19:33:12 INFO - 'LOGNAME': 'cltbld', 19:33:12 INFO - 'MAIL': '/var/mail/cltbld', 19:33:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:33:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:12 INFO - 'MOZ_NO_REMOTE': '1', 19:33:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:12 INFO - 'NO_EM_RESTART': '1', 19:33:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:12 INFO - 'PWD': '/builds/slave/test', 19:33:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:33:12 INFO - 'SHELL': '/bin/bash', 19:33:12 INFO - 'SHLVL': '1', 19:33:12 INFO - 'TERM': 'linux', 19:33:12 INFO - 'TMOUT': '86400', 19:33:12 INFO - 'USER': 'cltbld', 19:33:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579', 19:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:12 INFO - '_': '/tools/buildbot/bin/python'} 19:33:12 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/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 19:33:12 INFO - mozversion application_buildid: 20160403183818 19:33:12 INFO - mozversion application_changeset: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 19:33:12 INFO - mozversion application_display_name: Nightly 19:33:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:12 INFO - mozversion application_name: Firefox 19:33:12 INFO - mozversion application_remotingname: firefox 19:33:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:33:12 INFO - mozversion application_vendor: Mozilla 19:33:12 INFO - mozversion application_version: 48.0a1 19:33:12 INFO - mozversion platform_buildid: 20160403183818 19:33:12 INFO - mozversion platform_changeset: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 19:33:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:33:12 INFO - mozversion platform_version: 48.0a1 19:33:12 INFO - using testdate: 1459737192 19:33:12 INFO - actual date: 1459737192 19:33:12 INFO - starting webserver on 'localhost:56612' 19:33:12 INFO - SUITE-START | Running 2 tests 19:33:12 INFO - TEST-START | dromaeo_css 19:33:12 INFO - operating with platform_type : linux_ 19:33:12 INFO - Initialising browser for dromaeo_css test... 19:33:12 INFO - TEST-INFO | started process 3346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcHRbvG/profile http://localhost:56612/getInfo.html) 19:33:19 INFO - PROCESS | 3346 | __metrics Screen width/height:1600/1200 19:33:19 INFO - PROCESS | 3346 | colorDepth:24 19:33:19 INFO - PROCESS | 3346 | Browser inner width/height: 1024/697 19:33:19 INFO - PROCESS | 3346 | __metrics 19:33:20 ERROR - PROCESS | 3346 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:33:21 INFO - TEST-INFO | 3346: exit 0 19:33:21 INFO - Browser initialized. 19:33:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:21 INFO - TEST-INFO | started process 3427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcHRbvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:33 INFO - PROCESS | 3427 | RSS: Main: 154976256 19:33:33 INFO - PROCESS | 3427 | 19:34:24 INFO - PROCESS | 3427 | 1459737264199 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] 19:36:35 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56612/tests/dromaeo/cssquery-ext.html) 19:36:37 INFO - PROCESS | 3427 | RSS: Main: 271994880 19:36:37 INFO - PROCESS | 3427 | 19:39:39 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-ext.html (next: http://localhost:56612/tests/dromaeo/cssquery-jquery.html) 19:39:40 INFO - PROCESS | 3427 | RSS: Main: 239108096 19:39:40 INFO - PROCESS | 3427 | 19:42:42 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56612/tests/dromaeo/cssquery-mootools.html) 19:42:42 INFO - PROCESS | 3427 | RSS: Main: 236830720 19:42:42 INFO - PROCESS | 3427 | 19:45:44 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56612/tests/dromaeo/cssquery-prototype.html) 19:45:45 INFO - PROCESS | 3427 | RSS: Main: 201494528 19:45:45 INFO - PROCESS | 3427 | 19:48:48 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56612/tests/dromaeo/cssquery-yui.html) 19:48:48 INFO - PROCESS | 3427 | RSS: Main: 203026432 19:48:48 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:56612/tests/dromaeo/cssquery-yui.html (next: http://localhost:56612/tests/dromaeo/cssquery-dojo.html) 19:51:51 INFO - PROCESS | 3427 | RSS: Main: 270954496 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | __start_tp_report 19:51:51 INFO - PROCESS | 3427 | _x_x_mozilla_page_load 19:51:51 INFO - PROCESS | 3427 | _x_x_mozilla_page_load_details 19:51:51 INFO - PROCESS | 3427 | |i|pagename|runs| 19:51:51 INFO - PROCESS | 3427 | |0;dojo.html;2615.8430494170348;2681.1956413076073;2688.2607282997187;2695.528282550554;2723.1285988483683;4618.007128467379;4627.699199552027;4645.790939407726;4648.442186937568;4694.4601370842365;4617.884552886179;4646.651501137411;4659.976700116503;4693.671442998992;4735.905281894368;4174.561671024544;4197.391378250152;4217.36739489076;4243.108947121108;4329.956700433003;4250.277452833026;4280.336547835091;4280.507741609724;4340.110277393127;4349.499807522128;4130.896727581804;4204.453421055274;4221.430106935586;4231.1749208904275;4244.936325955113;4204.11713540157;4204.600562946515;4246.129543443618;4255.914881702349;4263.317869140923;4190.371444283352;4193.622573968327;4201.096764195712;4201.76890271035;4233.364995250707;4389.604935555783;4456.064226512436;4533.84131555394;4539.841105561322;4600.815967361302;4954.529319714621;4977.576905962997;4978.5270399312;4979.029089327582;5003.074431230198;4991.450940396553;4996.9500304996845;5005.699658020494;5006.098902197603;5054.292399064134;4565.018521017964;4651.209294419923;4683.882902927386;4762.095201911626;4767.308740232646;5088.92366614501;5099.36257967754;5105.617078719111;5109.718965456861;5111.207762796773;4895.33912921751;4900.901981960341;4904.166291730343;4904.485029071896;4940.061388336205;4826.058918510927;5007.574356179693;5044.54599086084;5076.314697515788;5084.313617661643;4883.096627123922;4889.071076495526;4899.755012249373;4907.631927605444;4942.184539550934;4829.058333624979;4881.829135980223;4897.314375987365;4897.510248975074;4948.628852836052;4129.091599848089;4170.103427762985;4181.644560212416;4250.149970006011;4271.6369108625495;3641.726870484671;3664.8900532984053;3671.908202294964;3709.6104908984166;3710.6103859094405;4304.20372231132;4307.698461107692;4319.416878721395;4320.611144996966;4355.412019377343;4861.4895435978715;5017.974910125426;5057.140286151363;5106.387233531926;5112.463191364927;4295.914081718348;4302.462192225972;4303.289957157034;4304.677149213759;4342.522322544518;4350.303951367766;4446.466424029072;4471.686981911235;4489.393931819228;4516.548345165457;4666.533346665306;4698;4699.318598803223;4738.123447162286;4751.714897106184;5009.574186194069;5032.521910418504;5032.521910418504;5035.924461133012;5056.443791183041;4596.494385617646;4685.437747470325;4723.787429565747;4731.053789242096;4788.090262850047;4912.533309335608;4937.21004639256;4950.653454258311;4973.428055773487;5001.599872010158;5005.949940500548;5011.373578302712;5018;5023.146065168857;5062.594992400525;4758.4765675776325;4803.975980120077;4885.120678277802;4889.877753056202;4913.680610760289;4856.39295088114;4866.1727506323305;4872.464028956882;4888.413390393175;4917.827876024322;4783.425988881357;4792.928106078341;4807.278908163804;4808.61531077506;4853.490383509822;4760.6191504678845;4771.355866957916;4828.227483602606;4881.585065269492;4901.975490122669;4681.602063824613;4727.125481785881;4792.424909010941;4792.448868380181;4810.735409552508 19:51:51 INFO - PROCESS | 3427 | |1;ext.html;531.5216305325207;531.9574434045275;535.7160704826441;548.341989612465;557.8019802969948;26644.733552664467;33720.15699607508;34257;34466.483002754976;34517.48223776645;37146.628533714655;37613.62386376136;37655.623443765624;37706;37747.24505509888;7575.1288601810675;7854.803629909269;7858.1356050834365;7858.135605083465;7858.607069646523;7730.961345193295;7833.921660783376;7837.882431763528;7852.21477852216;7866.292033716964;7796;8091.352691784643;8111.594420278992;8117.594120293991;8126.715564955228;7997.560134192617;8064.072631647318;8080;8083.676652933935;8092.473989190713;7563;7661.655225514865;7688.807779805494;7700.653470593837;7925.088614809255;37093.62906370929;37389;37535;37583.436248456295;37592.248155036745;2891.2000947287247;2922.839243841588;2945.7496112830436;3048.496997995328;3180.6819318068237;28272.717272827213;28521.71478285232;28697.85651071752;28806.71193288061;29022.709772902213;3055.282008727947;3063.5864158338563;3123.875044998197;3130.686931306851;3234.951475727866;182622;183157;183333;249599;249699.75150124315;42987.35518967218;43525.12949740987;56215.71892140595;56303;56766.43233567694;41598.584014159474;41619.1676166475;41632.795900512436;41641.58358416377;41683.58316416797;13315.933420332836;13409.597712068458;13410.463581456828;13440.32798360078;13477.123986940818;10920.726981825517;10964.671059868217;10984.560617575367;10989.175811814146;10990.615328463466;14704.705905882036;14721;14816.703665926836;14847.628809279639;14902.329395177243;5626.62147773798;5751.907137643834;5851.379745761429;5888.381719919433;5904.261967254093;855.6662901468433;855.8844555984863;873.5719497446332;888.6711916590773;900.3967341880956;26394.6040809388;26546.734532654813;26837.86581067082;27019.594706079424;27044.05345812887;776.1888826176659;960.7550074730899;976.8437050071955;1007.4257673126248;1014.452195814252;11883.643490695293;11940.701482462835;12164.574239901562;12511.812322815165;12710.36448177606;279484;282481;285087;285861;286702;41208.175836483104;41360.37959430611;41527;41998.16003679909;42068.158636827095;1043.5095505112586;1218.3786269002871;1252.7431876465303;1268.7462507498353;1323.7749582570793;24722.752772472766;26863;26934.865325673247;26953.460930781668;27041.45917081608;35946.28107437785;36335.81832090823;36387;37029.62970370369;37115.81442092772;164883.17558412132;174554;175518;175670;175766;31201;32173.678263218004;32330.676693232766;32700.182495437806;32723.836380817942;40095.3985690209;41518;41538;41782.164356712085;41799.164016720104;35115.47326790049;35192.29615407729;35234.64765352416;35484.645153549165;35570;34724.65275347315;35045.82477087598;35248.47127293144;35341.29317413689;35398;34650.13374665654;35360.29279414449;35486;35786.64213357833;35923;30801;31465;31502.054938351885;31505.527417088302;31509.36981260316;24227.878860605586;24426.389340266636;24700.876495618126;24947.62578561287;24968.37579060538 19:51:51 INFO - PROCESS | 3427 | |2;jquery.html;350.1840711143037;355.6088302866845;356.8073240450157;363.3332834249153;366.166970142925;15350.385984560618;15818.920905395471;16240.675186496263;16803.74794378082;16804.495865124067;10290.279680422373;10511.369317840936;12560.811587826167;16447.2598733057;16451.177441127926;4615.607673347769;4768.880777980544;4777.140114779356;4778.665493415462;4787.640926930477;3461.8096004719855;3719;4708.59976901962;6035.155078289043;6036.486898613623;5964.2246507953905;5982.3120341160675;5987.131865879445;6000.399960004008;6002.879942401171;3404.69357757803;5811.186433899257;5883.676397798119;5942.257217847769;5949.643021418707;6017.638941663514;6443.29123796382;6450.096986421905;6452.580582262138;6463.159789227418;20622.690659639968;20867.373978780663;21487.140514379407;21499.140034398606;21501.892490537604;2052.5381789097332;2068.720722702431;2080.417483104733;2163.113123619324;2363.7990770784504;13699.931500342434;13915.30423478822;14256.35846386915;14263.429462821474;14645.19451430171;1584.3583348743778;1594.338349584921;1596.880233982456;1600.2878718970062;1600.663860589266;70997.29002709959;71261.01158071839;71349.9297510543;71396;72567.63716181437;15022.999999999782;15057.967174431311;15192.772108418383;15258.542243732705;15272.007319524417;24996.750032499807;25269.74730252674;25400;25570.360740981625;25606.615900761502;8116.75649730509;8181.222783835526;8397.118302578263;8421.284190843724;8527.317814574819;6912.205096413977;6947.79156625302;6974.476914231453;6997.685104170325;7005.964970175219;7444.925550744531;7628.54228746277;7631.481611068445;7768.961155194301;7769.659046610012;2995.9364425629024;3061.127578640077;3063.5711000459955;3093.6751641077813;3200.727938125239;798.1180795221313;864.92215700586;915.5193523400268;936.9578368973413;963.9325247232766;11712.88287117118;15510.146941918303;15585.688286234212;15872.127033013296;16052.438164664181;795.2445177081795;813.0974618173823;866.1728049712509;888.2982443869271;914.8536234202629;8742.912570874338;8846.203841654282;8883.650913124548;8919.910800892038;8950;406960;411496;411907;412250;426299;64628.67685661541;65717.34282657207;66097.66951165309;69141.65429172822;73689;951.4101257220567;969.5249327829172;993.1707024634511;993.3146129170849;993.7515621094726;14885.702285954003;15039.097654140787;15085;15263;15401.460948866736;33937.66062339345;34823.12942176466;34878.651213488556;35309.823450882584;35802;48759.512404876914;48942;48990.51009489859;49127;49256.26115608197;7337.963310183415;7421.480496365202;7440.7023719052795;7477.738279160203;7526.887096693445;8766;10874;11232.382218977707;11295.604653837076;11383.690875549419;7324.890126647998;9520.857187142337;9839.950800246239;9883.901160988586;10003.29976901639;7209.3872020876715;9530.094641009093;9602.471864047544;9731.854022189815;9853.901460985586;9256.583453744732;9545.856812147684;9607.13535781783;9833.311668183158;10037.397756134655;6849.664315458637;6996.370326670624;7000.789976300719;7011.053507776589;7205.7838264852135;8310.501369917823;9282.025387334503;9301.813963720822;9449.669261575811;10012.59949602037 19:51:51 INFO - PROCESS | 3427 | |3;mootools.html;1283.5700040486436;1379.8689124533169;1387.1122481611767;1506.8794496440287;1728.6197036651931;6517.8370540736505;7105;7223.819404514877;7238.167610724775;7241.601711905843;7166.713331466748;7327.120745510533;7328.2412221066825;7339.926600733991;7341.192468828438;1895.753552038233;2135.946601334971;2182.2471247419617;2201.1085510368325;2214.7785221477884;2141.5395689926663;2150.2689085710854;2155.5473350596317;2155.741311042677;2157.029336798439;2097.64340062189;2176.6082105221053;2185.4317877351846;2189.6715492676067;2190.233418303597;2099.6955441460977;2124.851260411772;2124.9787502124937;2161.1247444784885;2162.5566758814407;2136.508603021314;2175.5213852952484;2185.0495034659975;2188.234118058667;2190.255313193506;7404.629768511553;7451.217622149705;7454.5899975501325;7471.887921681179;7482.363999060087;4528.796204170821;4644.95355046452;4650.18621741194;4651.023285110131;4654.953450465519;2809.887604495818;2881.8414987175697;2921.196670915494;2964.5553167024905;2971.4205729882683;927.9860802087974;940.9012053734327;961.4471678784657;965.8164948659733;989.5596459575492;10155.543000564992;10237.590496380137;10249.64126255585;10257.281990260684;10278.486075696186;4025.879223623296;4129.504459464883;4169.353750168729;4239.576042395735;4241.1941731071;8834.911650883409;8863.069377715376;8869.73390798277;8873.423227490193;8874.334424918157;4060.715749897479;4529.9547004530195;4539.75031373271;4570.651657760968;4583.931241031387;4002.899927501836;4062.756234625932;4090.4886889138857;4098.979505102515;4114.526829414595;3431.8627254909525;3480.408330583756;3523.066387407339;3534.858605655745;3545.2909418115964;1150.465033759306;1152.7002979225294;1164.3305099567783;1170.2861254634665;1177.0524727594368;1135.137295655308;1150.61454412771;1161.7734541764444;1163.3310846263432;1192.2965450384315;6864.828379290458;6868;6905.689243984033;6908.378245957788;7010.684519196649;1010.3281317923498;1038.85456036155;1042.921780866438;1055.1875056206677;1070.250824422907;5419.149860874574;5455.5908306877145;5466;5520.834374968757;5521.282233309644;8835.867461988075;9154.771130721785;9158.81682366349;9262.259019278441;9273.629054837731;9023.4134781239;9082.273418126533;9120.680776172801;9160.267178625694;9178.357514973888;6911.619860907598;7187.532810367309;7200.675969581382;7216.278372162742;7228.385587225145;6768.661566921536;6826.522143449911;6840.863182736417;6852.897206541807;6855.725770969106;7710.498817576839;7723.691052357843;7869.685212591432;7911.604419778873;7983.760487185394;7992.400569957393;7994.880076798736;8113.148119447609;8148.348132149295;8155.143709910374;5881.735321910439;6299.937000629935;6407.8718425630295;6445.70994305248;6619.3049729779605;6974.511784175059;6975.581465111906;6984.860302794017;7008.053912721921;7039.718411263492;6180.536459765445;6369.394907483782;6391.58454700443;6452.806415807533;6466;5982.790602328898;6050.818475445743;6053.061775424816;6130.141780150871;6150.415710507495;6468.676566171766;6547.9672601638595;6578.7368505261165;6579.276279609335;6598.538102332983;6089.147519347383;6214.347493513297;6242.906356404748;6244.531660125418;6252.906206406817;6181.196444462191;6182.227221597301;6183.938160618516;6191.597546159485;6235.064740288993 19:51:51 INFO - PROCESS | 3427 | |4;prototype.html;322.99031029069124;323.6650067180467;327.6854219948849;328.58434080887673;335.3159554508802;5290.89418211636;5346.064438723227;5383.327084114486;5399.62202645815;5411.215373770801;5272.23552584875;5292.338457692788;5322.414534401213;5325.707086110262;5333.573314134869;3938.1729836734175;4054.9189016219807;4113.5269444013875;4142.130152667944;4174.958250417495;4172.561881002496;4181.874543763677;4187.455630768011;4188.560201178878;4188.790560471979;4136.090060186754;4145.668346532285;4148.522919864224;4149.813258403379;4158.7296825706235;3931.2923673738715;4064.7764372959327;4147.087640719037;4150.398192262135;4151.91696166078;3659.505966694489;3667.339878821811;3668.413053911361;3676.926461470782;3680.2087551176623;5112.514311140436;5117.974410127963;5119.1553393690365;5125.103106956268;5132.0249152661245;4797.856064318076;4798.184308667535;4798.808047678089;4803.279508073782;4809.062232864558;5611.607187496877;5613.466720661571;5614.831555053314;5614.887702245973;5626.634268772516;4045.939310910339;4049.574794646549;4050.7569545827346;4052.2098190852794;4052.5542190359038;5611.130274807411;5780.682062486561;5781.913271300934;5784.82645520635;5792.986227410229;3903.33643280643;3978.7214894957074;4013.8394464221687;4029.778362190049;4037.152198038445;4087.550369459357;4088.9591104089172;4093.263212621757;4093.345064789679;4097;4686.27362758773;4691.366665500182;4691.953080469151;4702.764861756898;4708.576228139484;5623.240862483594;5632.183333416631;5642.266505354278;5644.943550564524;5646.096624540136;1412.2726795700223;1439.2372042817324;1443.0980637101811;1443.4298452111357;1444.1840360196456;894.4812009034745;936.7330310861372;944.7732544189345;959.3764053365369;965.5365424596233;4840.443349014909;4850.490698476679;4861.1006963711825;4904.43598986114;4928.162212423825;5750.827475175752;5751.568632352591;5759.971200143972;5765.221695071112;5767.682777447197;4904.926426103611;4912.410510738734;4914.5576898078625;4920.852374428773;4921.753912304371;3065.2796592800673;3106.4718997770433;3107.207662046209;3109.5335699644784;3110.2068972412344;5403;5404.432534583891;5408.3509978802795;5419.3225846769155;5423.918641220384;5675.77296908119;5889.7042650616795;5895.41045895407;5898.174255604219;5905.173275741399;5347.51872331492;5361.35663720356;5362.51737343641;5394.056040193029;5395.81114660985;5737.9139312911175;5739.8852022960145;5744.281964754406;5750.597458177887;5751.7411716472025;5617.522510586646;5638.718064096696;5645.830625081254;5652.604317697722;5656.519195868233;5392.919106213489;5394.622376433612;5400.081986062457;5404.918926216032;5406.053940560465;3899.883003509899;4007.4589930360194;4029.5567487576927;4030.7984600770433;4031.254217969685;5690.146478028329;5709.25779648643;5710.457506536873;5718.685472299064;5719.5138413235345;5498.835034948958;5528.087865502308;5531.695756733418;5535.837474130478;5538.584606154474;5528.308961379827;5529.889402212014;5537.916931246115;5542.528885044655;5544.972275138599;5428.7285635718845;5446.319210098738;5449.809256675997;5459.672419654833;5466.180072988925;5401.189821526802;5566.109422492382;5574.470425309589;5577.330720313588;5589.329280486368;5414.810481633282;5441.83674489766;5444.455554444524;5449;5450.1007333789485 19:51:51 INFO - PROCESS | 3427 | |5;yui.html;610.3896103896104;722.7217521254315;725.5392825555774;730.9634518274087;754.3512579181903;11189.832152517709;11257.887421125786;11304.265222760536;11313.943430282838;11318.886811131897;11038.17213708971;11096.167787415936;11133.610323638653;11147.275427097233;11150.498227579757;634.4004915354968;776.3323541754087;776.6543887969856;800.1958032177653;807.9030516338048;791.1574173505198;794.5431376958243;794.7377365469381;797.1868693932186;799.8280369720509;840.2857571064577;843.3927572148074;844.2064459408167;845.0915266088948;845.5476320168711;666.6933210723073;676.3777324861139;676.8341756269696;809.8623234050226;835.0355339582792;608.9573729838913;614.3395849461847;614.5759425996048;615.1541630258395;615.6921539230385;10447.529861156267;10458.79082418355;10459.529321180566;10471.84292235617;10476.63331783384;11687.649370518899;12378.133530652858;12586.937065314707;12899.806502902464;13009;9358.906410935939;9508.619655213783;9527.571259293349;9786.853197201977;10033.698989030341;3275.6233033201247;3290.4735242361107;3296.2583418730833;3398.2693720850134;3402.4045791986305;41706.1658766826;42118.578814211774;42185.36721949173;42520;42581;9239.39943903644;9386.389884657476;9401.10689484498;9413.435193888388;9534.570944307523;15017.624559386102;15313.387464501518;15521.223938803014;15522;15657.29542170605;6347.270063942613;6362.236531616236;6457.870842583122;6569.605823650596;6606.7026983785845;3465.7747246428903;3485.6735025928365;3500.1599616091953;3556.8043757593064;3652.123490362294;2808.0452646100425;2815.042885418967;2824.4209936962875;2834.3339315260896;2845.2460098074025;507.42407367638;507.5026474055446;513.432656914112;517.2629003669831;520.292402332827;570.7231992483643;571.2773341722724;572.936976932537;580.5848818095083;584.1967294969417;7941.205879412013;8213.096559378464;8221.958890205511;8299.792505187419;8366.748997530083;443.94672639283493;497.2888769060206;521.9060569097524;564.9943500564942;634.9873002539923;3604.225091605265;3688.9262214755554;3756.6619004289746;3776.244751049746;3910.804459777;48343.75828120907;49232;49322;49664.25503617449;49743.50256497389;43592.782036089615;44077.77961110238;44456.3331550027;44589.777051114535;44607.55392446099;39648.60351396507;40055.79972100121;40115;40868.1826363477;40962.9999999994;7688.692452301845;7733.419993500623;7744.457887948015;7815.92184078152;7838.137804841349;31469.685303146674;31521.184778344268;32301;32485.350292993535;32666.836665816518;37656.623433765315;37973.430398544595;40237.39643905402;40298;40962.590374095875;8919.152680495343;9001.954990225007;9023.413478124163;9259.814803704023;9266.860997084914;10388;10407.323523970917;10468.110210631878;10522.579096836042;10530.684079477627;9410.247180225702;9573.808523829624;9605.663801766905;9855.556499957376;9944.254180936314;9173.312001599774;9367.765805854908;9384.436933783994;9453.33826632129;9519.238460923249;9592.616295348107;9732.805343893224;9770.804583908424;9953.054459826304;10336.17310615164;8070.515769053875;8114.9778148489795;8364.038135614483;9206;9651.179649729851;9062.864057039018;9078.273738100805;9241.768955776159;9248.861267081134;9351 19:51:51 INFO - PROCESS | 3427 | __end_tp_report 19:51:51 INFO - PROCESS | 3427 | __start_cc_report 19:51:51 INFO - PROCESS | 3427 | _x_x_mozilla_cycle_collect,1097 19:51:51 INFO - PROCESS | 3427 | __end_cc_report 19:51:51 INFO - PROCESS | 3427 | __startTimestamp1459738311327__endTimestamp 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | ------- Summary: start ------- 19:51:51 INFO - PROCESS | 3427 | Number of tests: 6 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#0] dojo.html Cycles:165 Average:4597.76 Median:4738.12 stddev:481.43 (10.2%) stddev-sans-first:457.11 19:51:51 INFO - PROCESS | 3427 | Values: 2615.8 2681.2 2688.3 2695.5 2723.1 4618.0 4627.7 4645.8 4648.4 4694.5 4617.9 4646.7 4660.0 4693.7 4735.9 4174.6 4197.4 4217.4 4243.1 4330.0 4250.3 4280.3 4280.5 4340.1 4349.5 4130.9 4204.5 4221.4 4231.2 4244.9 4204.1 4204.6 4246.1 4255.9 4263.3 4190.4 4193.6 4201.1 4201.8 4233.4 4389.6 4456.1 4533.8 4539.8 4600.8 4954.5 4977.6 4978.5 4979.0 5003.1 4991.5 4997.0 5005.7 5006.1 5054.3 4565.0 4651.2 4683.9 4762.1 4767.3 5088.9 5099.4 5105.6 5109.7 5111.2 4895.3 4900.9 4904.2 4904.5 4940.1 4826.1 5007.6 5044.5 5076.3 5084.3 4883.1 4889.1 4899.8 4907.6 4942.2 4829.1 4881.8 4897.3 4897.5 4948.6 4129.1 4170.1 4181.6 4250.1 4271.6 3641.7 3664.9 3671.9 3709.6 3710.6 4304.2 4307.7 4319.4 4320.6 4355.4 4861.5 5018.0 5057.1 5106.4 5112.5 4295.9 4302.5 4303.3 4304.7 4342.5 4350.3 4446.5 4471.7 4489.4 4516.5 4666.5 4698.0 4699.3 4738.1 4751.7 5009.6 5032.5 5032.5 5035.9 5056.4 4596.5 4685.4 4723.8 4731.1 4788.1 4912.5 4937.2 4950.7 4973.4 5001.6 5005.9 5011.4 5018.0 5023.1 5062.6 4758.5 4804.0 4885.1 4889.9 4913.7 4856.4 4866.2 4872.5 4888.4 4917.8 4783.4 4792.9 4807.3 4808.6 4853.5 4760.6 4771.4 4828.2 4881.6 4902.0 4681.6 4727.1 4792.4 4792.4 4810.7 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#1] ext.html Cycles:180 Average:38039.27 Median:35153.88 stddev:59400.23 (169.0%) stddev-sans-first:59500.10 19:51:51 INFO - PROCESS | 3427 | Values: 531.5 532.0 535.7 548.3 557.8 26644.7 33720.2 34257.0 34466.5 34517.5 37146.6 37613.6 37655.6 37706.0 37747.2 7575.1 7854.8 7858.1 7858.1 7858.6 7731.0 7833.9 7837.9 7852.2 7866.3 7796.0 8091.4 8111.6 8117.6 8126.7 7997.6 8064.1 8080.0 8083.7 8092.5 7563.0 7661.7 7688.8 7700.7 7925.1 37093.6 37389.0 37535.0 37583.4 37592.2 2891.2 2922.8 2945.7 3048.5 3180.7 28272.7 28521.7 28697.9 28806.7 29022.7 3055.3 3063.6 3123.9 3130.7 3235.0 182622.0 183157.0 183333.0 249599.0 249699.8 42987.4 43525.1 56215.7 56303.0 56766.4 41598.6 41619.2 41632.8 41641.6 41683.6 13315.9 13409.6 13410.5 13440.3 13477.1 10920.7 10964.7 10984.6 10989.2 10990.6 14704.7 14721.0 14816.7 14847.6 14902.3 5626.6 5751.9 5851.4 5888.4 5904.3 855.7 855.9 873.6 888.7 900.4 26394.6 26546.7 26837.9 27019.6 27044.1 776.2 960.8 976.8 1007.4 1014.5 11883.6 11940.7 12164.6 12511.8 12710.4 279484.0 282481.0 285087.0 285861.0 286702.0 41208.2 41360.4 41527.0 41998.2 42068.2 1043.5 1218.4 1252.7 1268.7 1323.8 24722.8 26863.0 26934.9 26953.5 27041.5 35946.3 36335.8 36387.0 37029.6 37115.8 164883.2 174554.0 175518.0 175670.0 175766.0 31201.0 32173.7 32330.7 32700.2 32723.8 40095.4 41518.0 41538.0 41782.2 41799.2 35115.5 35192.3 35234.6 35484.6 35570.0 34724.7 35045.8 35248.5 35341.3 35398.0 34650.1 35360.3 35486.0 35786.6 35923.0 30801.0 31465.0 31502.1 31505.5 31509.4 24227.9 24426.4 24700.9 24947.6 24968.4 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#2] jquery.html Cycles:180 Average:25115.10 Median:27533.72 stddev:67957.06 (246.8%) stddev-sans-first:68122.26 19:51:51 INFO - PROCESS | 3427 | Values: 350.2 355.6 356.8 363.3 366.2 15350.4 15818.9 16240.7 16803.7 16804.5 10290.3 10511.4 12560.8 16447.3 16451.2 4615.6 4768.9 4777.1 4778.7 4787.6 3461.8 3719.0 4708.6 6035.2 6036.5 5964.2 5982.3 5987.1 6000.4 6002.9 3404.7 5811.2 5883.7 5942.3 5949.6 6017.6 6443.3 6450.1 6452.6 6463.2 20622.7 20867.4 21487.1 21499.1 21501.9 2052.5 2068.7 2080.4 2163.1 2363.8 13699.9 13915.3 14256.4 14263.4 14645.2 1584.4 1594.3 1596.9 1600.3 1600.7 70997.3 71261.0 71349.9 71396.0 72567.6 15023.0 15058.0 15192.8 15258.5 15272.0 24996.8 25269.7 25400.0 25570.4 25606.6 8116.8 8181.2 8397.1 8421.3 8527.3 6912.2 6947.8 6974.5 6997.7 7006.0 7444.9 7628.5 7631.5 7769.0 7769.7 2995.9 3061.1 3063.6 3093.7 3200.7 798.1 864.9 915.5 937.0 963.9 11712.9 15510.1 15585.7 15872.1 16052.4 795.2 813.1 866.2 888.3 914.9 8742.9 8846.2 8883.7 8919.9 8950.0 406960.0 411496.0 411907.0 412250.0 426299.0 64628.7 65717.3 66097.7 69141.7 73689.0 951.4 969.5 993.2 993.3 993.8 14885.7 15039.1 15085.0 15263.0 15401.5 33937.7 34823.1 34878.7 35309.8 35802.0 48759.5 48942.0 48990.5 49127.0 49256.3 7338.0 7421.5 7440.7 7477.7 7526.9 8766.0 10874.0 11232.4 11295.6 11383.7 7324.9 9520.9 9840.0 9883.9 10003.3 7209.4 9530.1 9602.5 9731.9 9853.9 9256.6 9545.9 9607.1 9833.3 10037.4 6849.7 6996.4 7000.8 7011.1 7205.8 8310.5 9282.0 9301.8 9449.7 10012.6 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#3] mootools.html Cycles:180 Average:5179.26 Median:6140.28 stddev:2683.56 (43.7%) stddev-sans-first:2675.11 19:51:51 INFO - PROCESS | 3427 | Values: 1283.6 1379.9 1387.1 1506.9 1728.6 6517.8 7105.0 7223.8 7238.2 7241.6 7166.7 7327.1 7328.2 7339.9 7341.2 1895.8 2135.9 2182.2 2201.1 2214.8 2141.5 2150.3 2155.5 2155.7 2157.0 2097.6 2176.6 2185.4 2189.7 2190.2 2099.7 2124.9 2125.0 2161.1 2162.6 2136.5 2175.5 2185.0 2188.2 2190.3 7404.6 7451.2 7454.6 7471.9 7482.4 4528.8 4645.0 4650.2 4651.0 4655.0 2809.9 2881.8 2921.2 2964.6 2971.4 928.0 940.9 961.4 965.8 989.6 10155.5 10237.6 10249.6 10257.3 10278.5 4025.9 4129.5 4169.4 4239.6 4241.2 8834.9 8863.1 8869.7 8873.4 8874.3 4060.7 4530.0 4539.8 4570.7 4583.9 4002.9 4062.8 4090.5 4099.0 4114.5 3431.9 3480.4 3523.1 3534.9 3545.3 1150.5 1152.7 1164.3 1170.3 1177.1 1135.1 1150.6 1161.8 1163.3 1192.3 6864.8 6868.0 6905.7 6908.4 7010.7 1010.3 1038.9 1042.9 1055.2 1070.3 5419.1 5455.6 5466.0 5520.8 5521.3 8835.9 9154.8 9158.8 9262.3 9273.6 9023.4 9082.3 9120.7 9160.3 9178.4 6911.6 7187.5 7200.7 7216.3 7228.4 6768.7 6826.5 6840.9 6852.9 6855.7 7710.5 7723.7 7869.7 7911.6 7983.8 7992.4 7994.9 8113.1 8148.3 8155.1 5881.7 6299.9 6407.9 6445.7 6619.3 6974.5 6975.6 6984.9 7008.1 7039.7 6180.5 6369.4 6391.6 6452.8 6466.0 5982.8 6050.8 6053.1 6130.1 6150.4 6468.7 6548.0 6578.7 6579.3 6598.5 6089.1 6214.3 6242.9 6244.5 6252.9 6181.2 6182.2 6183.9 6191.6 6235.1 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#4] prototype.html Cycles:180 Average:4627.58 Median:5339.82 stddev:1342.14 (25.1%) stddev-sans-first:1306.44 19:51:51 INFO - PROCESS | 3427 | Values: 323.0 323.7 327.7 328.6 335.3 5290.9 5346.1 5383.3 5399.6 5411.2 5272.2 5292.3 5322.4 5325.7 5333.6 3938.2 4054.9 4113.5 4142.1 4175.0 4172.6 4181.9 4187.5 4188.6 4188.8 4136.1 4145.7 4148.5 4149.8 4158.7 3931.3 4064.8 4147.1 4150.4 4151.9 3659.5 3667.3 3668.4 3676.9 3680.2 5112.5 5118.0 5119.2 5125.1 5132.0 4797.9 4798.2 4798.8 4803.3 4809.1 5611.6 5613.5 5614.8 5614.9 5626.6 4045.9 4049.6 4050.8 4052.2 4052.6 5611.1 5780.7 5781.9 5784.8 5793.0 3903.3 3978.7 4013.8 4029.8 4037.2 4087.6 4089.0 4093.3 4093.3 4097.0 4686.3 4691.4 4692.0 4702.8 4708.6 5623.2 5632.2 5642.3 5644.9 5646.1 1412.3 1439.2 1443.1 1443.4 1444.2 894.5 936.7 944.8 959.4 965.5 4840.4 4850.5 4861.1 4904.4 4928.2 5750.8 5751.6 5760.0 5765.2 5767.7 4904.9 4912.4 4914.6 4920.9 4921.8 3065.3 3106.5 3107.2 3109.5 3110.2 5403.0 5404.4 5408.4 5419.3 5423.9 5675.8 5889.7 5895.4 5898.2 5905.2 5347.5 5361.4 5362.5 5394.1 5395.8 5737.9 5739.9 5744.3 5750.6 5751.7 5617.5 5638.7 5645.8 5652.6 5656.5 5392.9 5394.6 5400.1 5404.9 5406.1 3899.9 4007.5 4029.6 4030.8 4031.3 5690.1 5709.3 5710.5 5718.7 5719.5 5498.8 5528.1 5531.7 5535.8 5538.6 5528.3 5529.9 5537.9 5542.5 5545.0 5428.7 5446.3 5449.8 5459.7 5466.2 5401.2 5566.1 5574.5 5577.3 5589.3 5414.8 5441.8 5444.5 5449.0 5450.1 19:51:51 INFO - PROCESS | 3427 | 19:51:51 INFO - PROCESS | 3427 | [#5] yui.html Cycles:180 Average:12103.53 Median:567.86 stddev:13878.20 (2444.0%) stddev-sans-first:13890.29 19:51:51 INFO - PROCESS | 3427 | Values: 610.4 722.7 725.5 731.0 754.4 11189.8 11257.9 11304.3 11313.9 11318.9 11038.2 11096.2 11133.6 11147.3 11150.5 634.4 776.3 776.7 800.2 807.9 791.2 794.5 794.7 797.2 799.8 840.3 843.4 844.2 845.1 845.5 666.7 676.4 676.8 809.9 835.0 609.0 614.3 614.6 615.2 615.7 10447.5 10458.8 10459.5 10471.8 10476.6 11687.6 12378.1 12586.9 12899.8 13009.0 9358.9 9508.6 9527.6 9786.9 10033.7 3275.6 3290.5 3296.3 3398.3 3402.4 41706.2 42118.6 42185.4 42520.0 42581.0 9239.4 9386.4 9401.1 9413.4 9534.6 15017.6 15313.4 15521.2 15522.0 15657.3 6347.3 6362.2 6457.9 6569.6 6606.7 3465.8 3485.7 3500.2 3556.8 3652.1 2808.0 2815.0 2824.4 2834.3 2845.2 507.4 507.5 513.4 517.3 520.3 570.7 571.3 572.9 580.6 584.2 7941.2 8213.1 8222.0 8299.8 8366.7 443.9 497.3 521.9 565.0 635.0 3604.2 3688.9 3756.7 3776.2 3910.8 48343.8 49232.0 49322.0 49664.3 49743.5 43592.8 44077.8 44456.3 44589.8 44607.6 39648.6 40055.8 40115.0 40868.2 40963.0 7688.7 7733.4 7744.5 7815.9 7838.1 31469.7 31521.2 32301.0 32485.4 32666.8 37656.6 37973.4 40237.4 40298.0 40962.6 8919.2 9002.0 9023.4 9259.8 9266.9 10388.0 10407.3 10468.1 10522.6 10530.7 9410.2 9573.8 9605.7 9855.6 9944.3 9173.3 9367.8 9384.4 9453.3 9519.2 9592.6 9732.8 9770.8 9953.1 10336.2 8070.5 8115.0 8364.0 9206.0 9651.2 9062.9 9078.3 9241.8 9248.9 9351.0 19:51:51 INFO - PROCESS | 3427 | -------- Summary: end -------- 19:51:51 INFO - PROCESS | 3427 | 19:51:52 INFO - TEST-INFO | 3427: exit 0 19:51:52 INFO - TEST-OK | dromaeo_css | took 1119226ms 19:51:52 INFO - TEST-START | kraken 19:51:52 INFO - operating with platform_type : linux_ 19:51:52 INFO - Initialising browser for kraken test... 19:51:52 INFO - TEST-INFO | started process 3606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrrOnz/profile http://localhost:56612/getInfo.html) 19:51:56 INFO - PROCESS | 3606 | __metrics Screen width/height:1600/1200 19:51:56 INFO - PROCESS | 3606 | colorDepth:24 19:51:56 INFO - PROCESS | 3606 | Browser inner width/height: 1024/697 19:51:56 INFO - PROCESS | 3606 | __metrics 19:51:57 ERROR - PROCESS | 3606 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:51:58 INFO - TEST-INFO | 3606: exit 0 19:51:58 INFO - Browser initialized. 19:51:58 INFO - Running cycle 1/1 for kraken test... 19:51:58 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrrOnz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:10 INFO - PROCESS | 3690 | RSS: Main: 154955776 19:52:10 INFO - PROCESS | 3690 | 19:52:13 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56612/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:13 INFO - PROCESS | 3690 | RSS: Main: 196337664 19:52:13 INFO - PROCESS | 3690 | 19:52:16 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56612/tests/kraken/driver.html?testName=audio-dft) 19:52:17 INFO - PROCESS | 3690 | RSS: Main: 185524224 19:52:17 INFO - PROCESS | 3690 | 19:52:20 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56612/tests/kraken/driver.html?testName=audio-fft) 19:52:20 INFO - PROCESS | 3690 | RSS: Main: 172060672 19:52:20 INFO - PROCESS | 3690 | 19:52:22 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56612/tests/kraken/driver.html?testName=audio-oscillator) 19:52:23 INFO - PROCESS | 3690 | RSS: Main: 172408832 19:52:23 INFO - PROCESS | 3690 | 19:52:25 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:26 INFO - PROCESS | 3690 | RSS: Main: 174166016 19:52:26 INFO - PROCESS | 3690 | 19:52:29 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56612/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:29 INFO - PROCESS | 3690 | RSS: Main: 174395392 19:52:29 INFO - PROCESS | 3690 | 19:52:33 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56612/tests/kraken/driver.html?testName=imaging-desaturate) 19:52:33 INFO - PROCESS | 3690 | RSS: Main: 174563328 19:52:33 INFO - PROCESS | 3690 | 19:52:36 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56612/tests/kraken/driver.html?testName=json-parse-financial) 19:52:37 INFO - PROCESS | 3690 | RSS: Main: 175296512 19:52:37 INFO - PROCESS | 3690 | 19:52:39 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:52:39 INFO - PROCESS | 3690 | RSS: Main: 187805696 19:52:39 INFO - PROCESS | 3690 | 19:52:41 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:52:42 INFO - PROCESS | 3690 | RSS: Main: 185126912 19:52:42 INFO - PROCESS | 3690 | 19:52:44 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:52:44 INFO - PROCESS | 3690 | RSS: Main: 196792320 19:52:44 INFO - PROCESS | 3690 | 19:52:47 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:52:48 INFO - PROCESS | 3690 | RSS: Main: 200519680 19:52:48 INFO - PROCESS | 3690 | 19:52:50 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:52:51 INFO - PROCESS | 3690 | RSS: Main: 200589312 19:52:51 INFO - PROCESS | 3690 | 19:52:52 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:56612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56612/tests/kraken/driver.html?testName=ai-astar) 19:52:53 INFO - PROCESS | 3690 | RSS: Main: 262184960 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | __start_tp_report 19:52:53 INFO - PROCESS | 3690 | _x_x_mozilla_page_load 19:52:53 INFO - PROCESS | 3690 | _x_x_mozilla_page_load_details 19:52:53 INFO - PROCESS | 3690 | |i|pagename|runs| 19:52:53 INFO - PROCESS | 3690 | |0;ai-astar;112;114;108;113;113;113;101;112;113;114 19:52:53 INFO - PROCESS | 3690 | |1;audio-beat-detection;163;145;158;173;143;169;157;136;174;132 19:52:53 INFO - PROCESS | 3690 | |2;audio-dft;160;160;162;161;160;160;162;161;160;163 19:52:53 INFO - PROCESS | 3690 | |3;audio-fft;74;74;111;109;78;74;73;105;104;76 19:52:53 INFO - PROCESS | 3690 | |4;audio-oscillator;92;93;132;93;94;94;138;93;93;132 19:52:53 INFO - PROCESS | 3690 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;116;117 19:52:53 INFO - PROCESS | 3690 | |6;imaging-darkroom;145;145;146;146;146;146;145;146;145;145 19:52:53 INFO - PROCESS | 3690 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 19:52:53 INFO - PROCESS | 3690 | |8;json-parse-financial;64;66;64;66;66;64;65;74;63;62 19:52:53 INFO - PROCESS | 3690 | |9;json-stringify-tinderbox;63;63;64;63;63;64;64;64;64;63 19:52:53 INFO - PROCESS | 3690 | |10;stanford-crypto-aes;81;89;90;99;92;83;83;85;82;84 19:52:53 INFO - PROCESS | 3690 | |11;stanford-crypto-ccm;116;116;117;118;126;119;119;122;117;115 19:52:53 INFO - PROCESS | 3690 | |12;stanford-crypto-pbkdf2;145;144;145;149;145;133;145;147;144;143 19:52:53 INFO - PROCESS | 3690 | |13;stanford-crypto-sha256-iterative;70;68;69;67;68;67;68;67;69;66 19:52:53 INFO - PROCESS | 3690 | __end_tp_report 19:52:53 INFO - PROCESS | 3690 | __start_cc_report 19:52:53 INFO - PROCESS | 3690 | _x_x_mozilla_cycle_collect,1177 19:52:53 INFO - PROCESS | 3690 | __end_cc_report 19:52:53 INFO - PROCESS | 3690 | __startTimestamp1459738373193__endTimestamp 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | ------- Summary: start ------- 19:52:53 INFO - PROCESS | 3690 | Number of tests: 14 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.00 (3.5%) stddev-sans-first:4.24 19:52:53 INFO - PROCESS | 3690 | Values: 112.0 114.0 108.0 113.0 113.0 113.0 101.0 112.0 113.0 114.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:160.50 stddev:15.25 (9.5%) stddev-sans-first:15.89 19:52:53 INFO - PROCESS | 3690 | Values: 163.0 145.0 158.0 173.0 143.0 169.0 157.0 136.0 174.0 132.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 19:52:53 INFO - PROCESS | 3690 | Values: 160.0 160.0 162.0 161.0 160.0 160.0 162.0 161.0 160.0 163.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:16.90 (22.8%) stddev-sans-first:17.18 19:52:53 INFO - PROCESS | 3690 | Values: 74.0 74.0 111.0 109.0 78.0 74.0 73.0 105.0 104.0 76.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.00 stddev:19.81 (21.3%) stddev-sans-first:20.41 19:52:53 INFO - PROCESS | 3690 | Values: 92.0 93.0 132.0 93.0 94.0 94.0 138.0 93.0 93.0 132.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:52:53 INFO - PROCESS | 3690 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:52:53 INFO - PROCESS | 3690 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:52:53 INFO - PROCESS | 3690 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:3.31 (5.0%) stddev-sans-first:3.47 19:52:53 INFO - PROCESS | 3690 | Values: 64.0 66.0 64.0 66.0 66.0 64.0 65.0 74.0 63.0 62.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:52:53 INFO - PROCESS | 3690 | Values: 63.0 63.0 64.0 63.0 63.0 64.0 64.0 64.0 64.0 63.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:5.65 (6.5%) stddev-sans-first:5.59 19:52:53 INFO - PROCESS | 3690 | Values: 81.0 89.0 90.0 99.0 92.0 83.0 83.0 85.0 82.0 84.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:3.31 (2.8%) stddev-sans-first:3.38 19:52:53 INFO - PROCESS | 3690 | Values: 116.0 116.0 117.0 118.0 126.0 119.0 119.0 122.0 117.0 115.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:145.00 stddev:4.22 (2.9%) stddev-sans-first:4.46 19:52:53 INFO - PROCESS | 3690 | Values: 145.0 144.0 145.0 149.0 145.0 133.0 145.0 147.0 144.0 143.0 19:52:53 INFO - PROCESS | 3690 | 19:52:53 INFO - PROCESS | 3690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 19:52:53 INFO - PROCESS | 3690 | Values: 70.0 68.0 69.0 67.0 68.0 67.0 68.0 67.0 69.0 66.0 19:52:53 INFO - PROCESS | 3690 | -------- Summary: end -------- 19:52:53 INFO - PROCESS | 3690 | 19:52:54 INFO - TEST-INFO | 3690: exit 0 19:52:54 INFO - TEST-OK | kraken | took 62050ms 19:52:54 INFO - SUITE-END | took 1181s 19:52:54 INFO - Completed test suite (00:19:41) 19:52:54 INFO - javascript benchmark 19:52:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.8430494170348, 2681.1956413076073, 2688.2607282997187, 2695.528282550554, 2723.1285988483683, 4618.007128467379, 4627.699199552027, 4645.790939407726, 4648.442186937568, 4694.4601370842365, 4617.884552886179, 4646.651501137411, 4659.976700116503, 4693.671442998992, 4735.905281894368, 4174.561671024544, 4197.391378250152, 4217.36739489076, 4243.108947121108, 4329.956700433003, 4250.277452833026, 4280.336547835091, 4280.507741609724, 4340.110277393127, 4349.499807522128, 4130.896727581804, 4204.453421055274, 4221.430106935586, 4231.1749208904275, 4244.936325955113, 4204.11713540157, 4204.600562946515, 4246.129543443618, 4255.914881702349, 4263.317869140923, 4190.371444283352, 4193.622573968327, 4201.096764195712, 4201.76890271035, 4233.364995250707, 4389.604935555783, 4456.064226512436, 4533.84131555394, 4539.841105561322, 4600.815967361302, 4954.529319714621, 4977.576905962997, 4978.5270399312, 4979.029089327582, 5003.074431230198, 4991.450940396553, 4996.9500304996845, 5005.699658020494, 5006.098902197603, 5054.292399064134, 4565.018521017964, 4651.209294419923, 4683.882902927386, 4762.095201911626, 4767.308740232646, 5088.92366614501, 5099.36257967754, 5105.617078719111, 5109.718965456861, 5111.207762796773, 4895.33912921751, 4900.901981960341, 4904.166291730343, 4904.485029071896, 4940.061388336205, 4826.058918510927, 5007.574356179693, 5044.54599086084, 5076.314697515788, 5084.313617661643, 4883.096627123922, 4889.071076495526, 4899.755012249373, 4907.631927605444, 4942.184539550934, 4829.058333624979, 4881.829135980223, 4897.314375987365, 4897.510248975074, 4948.628852836052, 4129.091599848089, 4170.103427762985, 4181.644560212416, 4250.149970006011, 4271.6369108625495, 3641.726870484671, 3664.8900532984053, 3671.908202294964, 3709.6104908984166, 3710.6103859094405, 4304.20372231132, 4307.698461107692, 4319.416878721395, 4320.611144996966, 4355.412019377343, 4861.4895435978715, 5017.974910125426, 5057.140286151363, 5106.387233531926, 5112.463191364927, 4295.914081718348, 4302.462192225972, 4303.289957157034, 4304.677149213759, 4342.522322544518, 4350.303951367766, 4446.466424029072, 4471.686981911235, 4489.393931819228, 4516.548345165457, 4666.533346665306, 4698.0, 4699.318598803223, 4738.123447162286, 4751.714897106184, 5009.574186194069, 5032.521910418504, 5032.521910418504, 5035.924461133012, 5056.443791183041, 4596.494385617646, 4685.437747470325, 4723.787429565747, 4731.053789242096, 4788.090262850047, 4912.533309335608, 4937.21004639256, 4950.653454258311, 4973.428055773487, 5001.599872010158, 5005.949940500548, 5011.373578302712, 5018.0, 5023.146065168857, 5062.594992400525, 4758.4765675776325, 4803.975980120077, 4885.120678277802, 4889.877753056202, 4913.680610760289, 4856.39295088114, 4866.1727506323305, 4872.464028956882, 4888.413390393175, 4917.827876024322, 4783.425988881357, 4792.928106078341, 4807.278908163804, 4808.61531077506, 4853.490383509822, 4760.6191504678845, 4771.355866957916, 4828.227483602606, 4881.585065269492, 4901.975490122669, 4681.602063824613, 4727.125481785881, 4792.424909010941, 4792.448868380181, 4810.735409552508], "unit": "score", "name": "dojo.html", "value": 4567.794496547937}, {"lowerIsBetter": false, "replicates": [531.5216305325207, 531.9574434045275, 535.7160704826441, 548.341989612465, 557.8019802969948, 26644.733552664467, 33720.15699607508, 34257.0, 34466.483002754976, 34517.48223776645, 37146.628533714655, 37613.62386376136, 37655.623443765624, 37706.0, 37747.24505509888, 7575.1288601810675, 7854.803629909269, 7858.1356050834365, 7858.135605083465, 7858.607069646523, 7730.961345193295, 7833.921660783376, 7837.882431763528, 7852.21477852216, 7866.292033716964, 7796.0, 8091.352691784643, 8111.594420278992, 8117.594120293991, 8126.715564955228, 7997.560134192617, 8064.072631647318, 8080.0, 8083.676652933935, 8092.473989190713, 7563.0, 7661.655225514865, 7688.807779805494, 7700.653470593837, 7925.088614809255, 37093.62906370929, 37389.0, 37535.0, 37583.436248456295, 37592.248155036745, 2891.2000947287247, 2922.839243841588, 2945.7496112830436, 3048.496997995328, 3180.6819318068237, 28272.717272827213, 28521.71478285232, 28697.85651071752, 28806.71193288061, 29022.709772902213, 3055.282008727947, 3063.5864158338563, 3123.875044998197, 3130.686931306851, 3234.951475727866, 182622.0, 183157.0, 183333.0, 249599.0, 249699.75150124315, 42987.35518967218, 43525.12949740987, 56215.71892140595, 56303.0, 56766.43233567694, 41598.584014159474, 41619.1676166475, 41632.795900512436, 41641.58358416377, 41683.58316416797, 13315.933420332836, 13409.597712068458, 13410.463581456828, 13440.32798360078, 13477.123986940818, 10920.726981825517, 10964.671059868217, 10984.560617575367, 10989.175811814146, 10990.615328463466, 14704.705905882036, 14721.0, 14816.703665926836, 14847.628809279639, 14902.329395177243, 5626.62147773798, 5751.907137643834, 5851.379745761429, 5888.381719919433, 5904.261967254093, 855.6662901468433, 855.8844555984863, 873.5719497446332, 888.6711916590773, 900.3967341880956, 26394.6040809388, 26546.734532654813, 26837.86581067082, 27019.594706079424, 27044.05345812887, 776.1888826176659, 960.7550074730899, 976.8437050071955, 1007.4257673126248, 1014.452195814252, 11883.643490695293, 11940.701482462835, 12164.574239901562, 12511.812322815165, 12710.36448177606, 279484.0, 282481.0, 285087.0, 285861.0, 286702.0, 41208.175836483104, 41360.37959430611, 41527.0, 41998.16003679909, 42068.158636827095, 1043.5095505112586, 1218.3786269002871, 1252.7431876465303, 1268.7462507498353, 1323.7749582570793, 24722.752772472766, 26863.0, 26934.865325673247, 26953.460930781668, 27041.45917081608, 35946.28107437785, 36335.81832090823, 36387.0, 37029.62970370369, 37115.81442092772, 164883.17558412132, 174554.0, 175518.0, 175670.0, 175766.0, 31201.0, 32173.678263218004, 32330.676693232766, 32700.182495437806, 32723.836380817942, 40095.3985690209, 41518.0, 41538.0, 41782.164356712085, 41799.164016720104, 35115.47326790049, 35192.29615407729, 35234.64765352416, 35484.645153549165, 35570.0, 34724.65275347315, 35045.82477087598, 35248.47127293144, 35341.29317413689, 35398.0, 34650.13374665654, 35360.29279414449, 35486.0, 35786.64213357833, 35923.0, 30801.0, 31465.0, 31502.054938351885, 31505.527417088302, 31509.36981260316, 24227.878860605586, 24426.389340266636, 24700.876495618126, 24947.62578561287, 24968.37579060538], "unit": "score", "name": "ext.html", "value": 16195.355083601777}, {"lowerIsBetter": false, "replicates": [350.1840711143037, 355.6088302866845, 356.8073240450157, 363.3332834249153, 366.166970142925, 15350.385984560618, 15818.920905395471, 16240.675186496263, 16803.74794378082, 16804.495865124067, 10290.279680422373, 10511.369317840936, 12560.811587826167, 16447.2598733057, 16451.177441127926, 4615.607673347769, 4768.880777980544, 4777.140114779356, 4778.665493415462, 4787.640926930477, 3461.8096004719855, 3719.0, 4708.59976901962, 6035.155078289043, 6036.486898613623, 5964.2246507953905, 5982.3120341160675, 5987.131865879445, 6000.399960004008, 6002.879942401171, 3404.69357757803, 5811.186433899257, 5883.676397798119, 5942.257217847769, 5949.643021418707, 6017.638941663514, 6443.29123796382, 6450.096986421905, 6452.580582262138, 6463.159789227418, 20622.690659639968, 20867.373978780663, 21487.140514379407, 21499.140034398606, 21501.892490537604, 2052.5381789097332, 2068.720722702431, 2080.417483104733, 2163.113123619324, 2363.7990770784504, 13699.931500342434, 13915.30423478822, 14256.35846386915, 14263.429462821474, 14645.19451430171, 1584.3583348743778, 1594.338349584921, 1596.880233982456, 1600.2878718970062, 1600.663860589266, 70997.29002709959, 71261.01158071839, 71349.9297510543, 71396.0, 72567.63716181437, 15022.999999999782, 15057.967174431311, 15192.772108418383, 15258.542243732705, 15272.007319524417, 24996.750032499807, 25269.74730252674, 25400.0, 25570.360740981625, 25606.615900761502, 8116.75649730509, 8181.222783835526, 8397.118302578263, 8421.284190843724, 8527.317814574819, 6912.205096413977, 6947.79156625302, 6974.476914231453, 6997.685104170325, 7005.964970175219, 7444.925550744531, 7628.54228746277, 7631.481611068445, 7768.961155194301, 7769.659046610012, 2995.9364425629024, 3061.127578640077, 3063.5711000459955, 3093.6751641077813, 3200.727938125239, 798.1180795221313, 864.92215700586, 915.5193523400268, 936.9578368973413, 963.9325247232766, 11712.88287117118, 15510.146941918303, 15585.688286234212, 15872.127033013296, 16052.438164664181, 795.2445177081795, 813.0974618173823, 866.1728049712509, 888.2982443869271, 914.8536234202629, 8742.912570874338, 8846.203841654282, 8883.650913124548, 8919.910800892038, 8950.0, 406960.0, 411496.0, 411907.0, 412250.0, 426299.0, 64628.67685661541, 65717.34282657207, 66097.66951165309, 69141.65429172822, 73689.0, 951.4101257220567, 969.5249327829172, 993.1707024634511, 993.3146129170849, 993.7515621094726, 14885.702285954003, 15039.097654140787, 15085.0, 15263.0, 15401.460948866736, 33937.66062339345, 34823.12942176466, 34878.651213488556, 35309.823450882584, 35802.0, 48759.512404876914, 48942.0, 48990.51009489859, 49127.0, 49256.26115608197, 7337.963310183415, 7421.480496365202, 7440.7023719052795, 7477.738279160203, 7526.887096693445, 8766.0, 10874.0, 11232.382218977707, 11295.604653837076, 11383.690875549419, 7324.890126647998, 9520.857187142337, 9839.950800246239, 9883.901160988586, 10003.29976901639, 7209.3872020876715, 9530.094641009093, 9602.471864047544, 9731.854022189815, 9853.901460985586, 9256.583453744732, 9545.856812147684, 9607.13535781783, 9833.311668183158, 10037.397756134655, 6849.664315458637, 6996.370326670624, 7000.789976300719, 7011.053507776589, 7205.7838264852135, 8310.501369917823, 9282.025387334503, 9301.813963720822, 9449.669261575811, 10012.59949602037], "unit": "score", "name": "jquery.html", "value": 8597.940613224937}, {"lowerIsBetter": false, "replicates": [1283.5700040486436, 1379.8689124533169, 1387.1122481611767, 1506.8794496440287, 1728.6197036651931, 6517.8370540736505, 7105.0, 7223.819404514877, 7238.167610724775, 7241.601711905843, 7166.713331466748, 7327.120745510533, 7328.2412221066825, 7339.926600733991, 7341.192468828438, 1895.753552038233, 2135.946601334971, 2182.2471247419617, 2201.1085510368325, 2214.7785221477884, 2141.5395689926663, 2150.2689085710854, 2155.5473350596317, 2155.741311042677, 2157.029336798439, 2097.64340062189, 2176.6082105221053, 2185.4317877351846, 2189.6715492676067, 2190.233418303597, 2099.6955441460977, 2124.851260411772, 2124.9787502124937, 2161.1247444784885, 2162.5566758814407, 2136.508603021314, 2175.5213852952484, 2185.0495034659975, 2188.234118058667, 2190.255313193506, 7404.629768511553, 7451.217622149705, 7454.5899975501325, 7471.887921681179, 7482.363999060087, 4528.796204170821, 4644.95355046452, 4650.18621741194, 4651.023285110131, 4654.953450465519, 2809.887604495818, 2881.8414987175697, 2921.196670915494, 2964.5553167024905, 2971.4205729882683, 927.9860802087974, 940.9012053734327, 961.4471678784657, 965.8164948659733, 989.5596459575492, 10155.543000564992, 10237.590496380137, 10249.64126255585, 10257.281990260684, 10278.486075696186, 4025.879223623296, 4129.504459464883, 4169.353750168729, 4239.576042395735, 4241.1941731071, 8834.911650883409, 8863.069377715376, 8869.73390798277, 8873.423227490193, 8874.334424918157, 4060.715749897479, 4529.9547004530195, 4539.75031373271, 4570.651657760968, 4583.931241031387, 4002.899927501836, 4062.756234625932, 4090.4886889138857, 4098.979505102515, 4114.526829414595, 3431.8627254909525, 3480.408330583756, 3523.066387407339, 3534.858605655745, 3545.2909418115964, 1150.465033759306, 1152.7002979225294, 1164.3305099567783, 1170.2861254634665, 1177.0524727594368, 1135.137295655308, 1150.61454412771, 1161.7734541764444, 1163.3310846263432, 1192.2965450384315, 6864.828379290458, 6868.0, 6905.689243984033, 6908.378245957788, 7010.684519196649, 1010.3281317923498, 1038.85456036155, 1042.921780866438, 1055.1875056206677, 1070.250824422907, 5419.149860874574, 5455.5908306877145, 5466.0, 5520.834374968757, 5521.282233309644, 8835.867461988075, 9154.771130721785, 9158.81682366349, 9262.259019278441, 9273.629054837731, 9023.4134781239, 9082.273418126533, 9120.680776172801, 9160.267178625694, 9178.357514973888, 6911.619860907598, 7187.532810367309, 7200.675969581382, 7216.278372162742, 7228.385587225145, 6768.661566921536, 6826.522143449911, 6840.863182736417, 6852.897206541807, 6855.725770969106, 7710.498817576839, 7723.691052357843, 7869.685212591432, 7911.604419778873, 7983.760487185394, 7992.400569957393, 7994.880076798736, 8113.148119447609, 8148.348132149295, 8155.143709910374, 5881.735321910439, 6299.937000629935, 6407.8718425630295, 6445.70994305248, 6619.3049729779605, 6974.511784175059, 6975.581465111906, 6984.860302794017, 7008.053912721921, 7039.718411263492, 6180.536459765445, 6369.394907483782, 6391.58454700443, 6452.806415807533, 6466.0, 5982.790602328898, 6050.818475445743, 6053.061775424816, 6130.141780150871, 6150.415710507495, 6468.676566171766, 6547.9672601638595, 6578.7368505261165, 6579.276279609335, 6598.538102332983, 6089.147519347383, 6214.347493513297, 6242.906356404748, 6244.531660125418, 6252.906206406817, 6181.196444462191, 6182.227221597301, 6183.938160618516, 6191.597546159485, 6235.064740288993], "unit": "score", "name": "mootools.html", "value": 4264.844267662284}, {"lowerIsBetter": false, "replicates": [322.99031029069124, 323.6650067180467, 327.6854219948849, 328.58434080887673, 335.3159554508802, 5290.89418211636, 5346.064438723227, 5383.327084114486, 5399.62202645815, 5411.215373770801, 5272.23552584875, 5292.338457692788, 5322.414534401213, 5325.707086110262, 5333.573314134869, 3938.1729836734175, 4054.9189016219807, 4113.5269444013875, 4142.130152667944, 4174.958250417495, 4172.561881002496, 4181.874543763677, 4187.455630768011, 4188.560201178878, 4188.790560471979, 4136.090060186754, 4145.668346532285, 4148.522919864224, 4149.813258403379, 4158.7296825706235, 3931.2923673738715, 4064.7764372959327, 4147.087640719037, 4150.398192262135, 4151.91696166078, 3659.505966694489, 3667.339878821811, 3668.413053911361, 3676.926461470782, 3680.2087551176623, 5112.514311140436, 5117.974410127963, 5119.1553393690365, 5125.103106956268, 5132.0249152661245, 4797.856064318076, 4798.184308667535, 4798.808047678089, 4803.279508073782, 4809.062232864558, 5611.607187496877, 5613.466720661571, 5614.831555053314, 5614.887702245973, 5626.634268772516, 4045.939310910339, 4049.574794646549, 4050.7569545827346, 4052.2098190852794, 4052.5542190359038, 5611.130274807411, 5780.682062486561, 5781.913271300934, 5784.82645520635, 5792.986227410229, 3903.33643280643, 3978.7214894957074, 4013.8394464221687, 4029.778362190049, 4037.152198038445, 4087.550369459357, 4088.9591104089172, 4093.263212621757, 4093.345064789679, 4097.0, 4686.27362758773, 4691.366665500182, 4691.953080469151, 4702.764861756898, 4708.576228139484, 5623.240862483594, 5632.183333416631, 5642.266505354278, 5644.943550564524, 5646.096624540136, 1412.2726795700223, 1439.2372042817324, 1443.0980637101811, 1443.4298452111357, 1444.1840360196456, 894.4812009034745, 936.7330310861372, 944.7732544189345, 959.3764053365369, 965.5365424596233, 4840.443349014909, 4850.490698476679, 4861.1006963711825, 4904.43598986114, 4928.162212423825, 5750.827475175752, 5751.568632352591, 5759.971200143972, 5765.221695071112, 5767.682777447197, 4904.926426103611, 4912.410510738734, 4914.5576898078625, 4920.852374428773, 4921.753912304371, 3065.2796592800673, 3106.4718997770433, 3107.207662046209, 3109.5335699644784, 3110.2068972412344, 5403.0, 5404.432534583891, 5408.3509978802795, 5419.3225846769155, 5423.918641220384, 5675.77296908119, 5889.7042650616795, 5895.41045895407, 5898.174255604219, 5905.173275741399, 5347.51872331492, 5361.35663720356, 5362.51737343641, 5394.056040193029, 5395.81114660985, 5737.9139312911175, 5739.8852022960145, 5744.281964754406, 5750.597458177887, 5751.7411716472025, 5617.522510586646, 5638.718064096696, 5645.830625081254, 5652.604317697722, 5656.519195868233, 5392.919106213489, 5394.622376433612, 5400.081986062457, 5404.918926216032, 5406.053940560465, 3899.883003509899, 4007.4589930360194, 4029.5567487576927, 4030.7984600770433, 4031.254217969685, 5690.146478028329, 5709.25779648643, 5710.457506536873, 5718.685472299064, 5719.5138413235345, 5498.835034948958, 5528.087865502308, 5531.695756733418, 5535.837474130478, 5538.584606154474, 5528.308961379827, 5529.889402212014, 5537.916931246115, 5542.528885044655, 5544.972275138599, 5428.7285635718845, 5446.319210098738, 5449.809256675997, 5459.672419654833, 5466.180072988925, 5401.189821526802, 5566.109422492382, 5574.470425309589, 5577.330720313588, 5589.329280486368, 5414.810481633282, 5441.83674489766, 5444.455554444524, 5449.0, 5450.1007333789485], "unit": "score", "name": "prototype.html", "value": 4200.160284569841}, {"lowerIsBetter": false, "replicates": [610.3896103896104, 722.7217521254315, 725.5392825555774, 730.9634518274087, 754.3512579181903, 11189.832152517709, 11257.887421125786, 11304.265222760536, 11313.943430282838, 11318.886811131897, 11038.17213708971, 11096.167787415936, 11133.610323638653, 11147.275427097233, 11150.498227579757, 634.4004915354968, 776.3323541754087, 776.6543887969856, 800.1958032177653, 807.9030516338048, 791.1574173505198, 794.5431376958243, 794.7377365469381, 797.1868693932186, 799.8280369720509, 840.2857571064577, 843.3927572148074, 844.2064459408167, 845.0915266088948, 845.5476320168711, 666.6933210723073, 676.3777324861139, 676.8341756269696, 809.8623234050226, 835.0355339582792, 608.9573729838913, 614.3395849461847, 614.5759425996048, 615.1541630258395, 615.6921539230385, 10447.529861156267, 10458.79082418355, 10459.529321180566, 10471.84292235617, 10476.63331783384, 11687.649370518899, 12378.133530652858, 12586.937065314707, 12899.806502902464, 13009.0, 9358.906410935939, 9508.619655213783, 9527.571259293349, 9786.853197201977, 10033.698989030341, 3275.6233033201247, 3290.4735242361107, 3296.2583418730833, 3398.2693720850134, 3402.4045791986305, 41706.1658766826, 42118.578814211774, 42185.36721949173, 42520.0, 42581.0, 9239.39943903644, 9386.389884657476, 9401.10689484498, 9413.435193888388, 9534.570944307523, 15017.624559386102, 15313.387464501518, 15521.223938803014, 15522.0, 15657.29542170605, 6347.270063942613, 6362.236531616236, 6457.870842583122, 6569.605823650596, 6606.7026983785845, 3465.7747246428903, 3485.6735025928365, 3500.1599616091953, 3556.8043757593064, 3652.123490362294, 2808.0452646100425, 2815.042885418967, 2824.4209936962875, 2834.3339315260896, 2845.2460098074025, 507.42407367638, 507.5026474055446, 513.432656914112, 517.2629003669831, 520.292402332827, 570.7231992483643, 571.2773341722724, 572.936976932537, 580.5848818095083, 584.1967294969417, 7941.205879412013, 8213.096559378464, 8221.958890205511, 8299.792505187419, 8366.748997530083, 443.94672639283493, 497.2888769060206, 521.9060569097524, 564.9943500564942, 634.9873002539923, 3604.225091605265, 3688.9262214755554, 3756.6619004289746, 3776.244751049746, 3910.804459777, 48343.75828120907, 49232.0, 49322.0, 49664.25503617449, 49743.50256497389, 43592.782036089615, 44077.77961110238, 44456.3331550027, 44589.777051114535, 44607.55392446099, 39648.60351396507, 40055.79972100121, 40115.0, 40868.1826363477, 40962.9999999994, 7688.692452301845, 7733.419993500623, 7744.457887948015, 7815.92184078152, 7838.137804841349, 31469.685303146674, 31521.184778344268, 32301.0, 32485.350292993535, 32666.836665816518, 37656.623433765315, 37973.430398544595, 40237.39643905402, 40298.0, 40962.590374095875, 8919.152680495343, 9001.954990225007, 9023.413478124163, 9259.814803704023, 9266.860997084914, 10388.0, 10407.323523970917, 10468.110210631878, 10522.579096836042, 10530.684079477627, 9410.247180225702, 9573.808523829624, 9605.663801766905, 9855.556499957376, 9944.254180936314, 9173.312001599774, 9367.765805854908, 9384.436933783994, 9453.33826632129, 9519.238460923249, 9592.616295348107, 9732.805343893224, 9770.804583908424, 9953.054459826304, 10336.17310615164, 8070.515769053875, 8114.9778148489795, 8364.038135614483, 9206.0, 9651.179649729851, 9062.864057039018, 9078.273738100805, 9241.768955776159, 9248.861267081134, 9351.0], "unit": "score", "name": "yui.html", "value": 5619.121158796811}], "name": "dromaeo_css", "value": 6325.021033140573}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 113.0, 113.0, 113.0, 101.0, 112.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [163.0, 145.0, 158.0, 173.0, 143.0, 169.0, 157.0, 136.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 111.0, 109.0, 78.0, 74.0, 73.0, 105.0, 104.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 132.0, 93.0, 94.0, 94.0, 138.0, 93.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 66.0, 66.0, 64.0, 65.0, 74.0, 63.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 90.0, 99.0, 92.0, 83.0, 83.0, 85.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 118.0, 126.0, 119.0, 119.0, 122.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 149.0, 145.0, 133.0, 145.0, 147.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0, 67.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1523.8000000000002}]} 19:52:54 INFO - Return code: 0 19:52:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:52:54 ERROR - # TBPL SUCCESS # 19:52:54 INFO - Running post-action listener: _resource_record_post_action 19:52:54 INFO - Running post-run listener: _resource_record_post_run 19:52:55 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8151040; Write bytes: 405049344; Read time: 2212; Write time: 453576 19:52:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5230592; Read time: 0; Write time: 648 19:52:55 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 6414336; Write bytes: 399818752; Read time: 2172; Write time: 452928 19:52:55 INFO - Running post-run listener: _upload_blobber_files 19:52:55 INFO - Blob upload gear active. 19:52:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:52:55 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 19:52:55 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'] 19:52:55 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 19:52:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:56 INFO - (blobuploader) - INFO - Done attempting. 19:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:52:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:57 INFO - (blobuploader) - INFO - Done attempting. 19:52:57 INFO - (blobuploader) - INFO - Iteration through files over. 19:52:57 INFO - Return code: 0 19:52:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:52:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:52:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f05e791b750575b60b597a9183002b6cf55441d0ca1070eb28bd95ff74a6b37397841aab46689135b28de320501cac8eee4f001b9da3deb65c7eb032eccdb6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/035a92a9741984a372b798e74b127aef8ee78020b2f16280edb05ddd88f538f422c2136b7973502de56eda4f7d351b0f76e5d05c8a241078c734c261581ec346"} 19:52:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:52:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:52:57 INFO - Contents: 19:52:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f05e791b750575b60b597a9183002b6cf55441d0ca1070eb28bd95ff74a6b37397841aab46689135b28de320501cac8eee4f001b9da3deb65c7eb032eccdb6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/035a92a9741984a372b798e74b127aef8ee78020b2f16280edb05ddd88f538f422c2136b7973502de56eda4f7d351b0f76e5d05c8a241078c734c261581ec346"} 19:52:57 INFO - Running post-run listener: copy_logs_to_upload_dir 19:52:57 INFO - Copying logs to upload dir... 19:52:57 INFO - mkdir: /builds/slave/test/build/upload/logs 19:52:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.953658 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-03 19:52:57.514168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 19:52:57.517676) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 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/2f05e791b750575b60b597a9183002b6cf55441d0ca1070eb28bd95ff74a6b37397841aab46689135b28de320501cac8eee4f001b9da3deb65c7eb032eccdb6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/035a92a9741984a372b798e74b127aef8ee78020b2f16280edb05ddd88f538f422c2136b7973502de56eda4f7d351b0f76e5d05c8a241078c734c261581ec346"} build_url:https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/LAzfUj9bROGjLRxpdnH2nQ/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/2f05e791b750575b60b597a9183002b6cf55441d0ca1070eb28bd95ff74a6b37397841aab46689135b28de320501cac8eee4f001b9da3deb65c7eb032eccdb6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/035a92a9741984a372b798e74b127aef8ee78020b2f16280edb05ddd88f538f422c2136b7973502de56eda4f7d351b0f76e5d05c8a241078c734c261581ec346"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 19:52:57.542317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:52:57.542665) ========= 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=4ac8d263c7293b36a1be1aed000001be-1459714097.571158-1792358579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 19:52:57.628592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 19:52:57.629001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 19:52:57.629332) ========= ========= Total master_lag: 0.34 =========