builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1458587757.27 results: success (0) buildid: 20160321112834 builduid: 178b039e54474b96b36303247c1214e7 revision: 216d9ae88a315bed4961b121fb96f930411cf4b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.273763) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.274204) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.274482) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test' ========= master_lag: 0.19 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.474802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.475112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.912040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:57.912483) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:58.156914) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:58.157234) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:58.157584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:58.157845) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 12:15:58-- 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% 81.9M=0s 2016-03-21 12:15:58 (81.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.641888 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:15:58.909462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-21 12:15:58.909762) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014766 ========= master_lag: 6.52 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-21 12:16:05.441863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-21 12:16:05.442282) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 216d9ae88a315bed4961b121fb96f930411cf4b2 --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 216d9ae88a315bed4961b121fb96f930411cf4b2 --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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 12:16:05,591 truncating revision to first 12 chars 2016-03-21 12:16:05,591 Setting DEBUG logging. 2016-03-21 12:16:05,591 attempt 1/10 2016-03-21 12:16:05,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/216d9ae88a31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 12:16:07,016 unpacking tar archive at: fx-team-216d9ae88a31/testing/mozharness/ program finished with exit code 0 elapsedTime=2.398814 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-21 12:16:07.953839) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 12:16:07.954226) ========= echo 216d9ae88a315bed4961b121fb96f930411cf4b2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'216d9ae88a315bed4961b121fb96f930411cf4b2'] 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 216d9ae88a315bed4961b121fb96f930411cf4b2 program finished with exit code 0 elapsedTime=0.004726 script_repo_revision: '216d9ae88a315bed4961b121fb96f930411cf4b2' ========= master_lag: 0.21 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 12:16:08.165890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 12:16:08.166191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 12:16:08.476116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-03-21 12:16:08.476483) ========= /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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:08 INFO - MultiFileLogger online at 20160321 12:16:08 in /builds/slave/test 12:16:08 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 12:16:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:08 INFO - {'append_to_log': False, 12:16:08 INFO - 'base_work_dir': '/builds/slave/test', 12:16:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:16:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:08 INFO - 'branch': 'Fx-Team-Non-PGO', 12:16:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:08 INFO - 'config_files': ('talos/linux_config.py',), 12:16:08 INFO - 'default_actions': ('clobber', 12:16:08 INFO - 'read-buildbot-config', 12:16:08 INFO - 'download-and-extract', 12:16:08 INFO - 'populate-webroot', 12:16:08 INFO - 'create-virtualenv', 12:16:08 INFO - 'install', 12:16:08 INFO - 'run-tests'), 12:16:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:08 INFO - 'download_minidump_stackwalk': True, 12:16:08 INFO - 'download_symbols': 'ondemand', 12:16:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:08 INFO - 'installer_path': 'installer.exe', 12:16:08 INFO - 'log_level': 'info', 12:16:08 INFO - 'log_name': 'talos', 12:16:08 INFO - 'log_to_console': True, 12:16:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:08 INFO - 'opt_config_files': (), 12:16:08 INFO - 'pip_index': False, 12:16:08 INFO - 'sps_profile': False, 12:16:08 INFO - 'sps_profile_interval': 0, 12:16:08 INFO - 'suite': 'dromaeojs', 12:16:08 INFO - 'system_bits': '32', 12:16:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:08 INFO - 'title': 'talos-linux64-ix-027', 12:16:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:08 INFO - 'use_talos_json': True, 12:16:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:08 INFO - 'work_dir': 'build'} 12:16:08 INFO - ##### 12:16:08 INFO - ##### Running clobber step. 12:16:08 INFO - ##### 12:16:08 INFO - Running pre-action listener: _resource_record_pre_action 12:16:08 INFO - Running main action method: clobber 12:16:08 INFO - rmtree: /builds/slave/test/build 12:16:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:09 INFO - Running post-action listener: _resource_record_post_action 12:16:09 INFO - ##### 12:16:09 INFO - ##### Running read-buildbot-config step. 12:16:09 INFO - ##### 12:16:09 INFO - Running pre-action listener: _resource_record_pre_action 12:16:09 INFO - Running main action method: read_buildbot_config 12:16:09 INFO - Using buildbot properties: 12:16:09 INFO - { 12:16:09 INFO - "project": "", 12:16:09 INFO - "product": "firefox", 12:16:09 INFO - "script_repo_revision": "production", 12:16:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:09 INFO - "repository": "", 12:16:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:16:09 INFO - "buildid": "20160321112834", 12:16:09 INFO - "pgo_build": "False", 12:16:09 INFO - "basedir": "/builds/slave/test", 12:16:09 INFO - "buildnumber": 1484, 12:16:09 INFO - "slavename": "talos-linux64-ix-027", 12:16:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:16:09 INFO - "platform": "ubuntu64_hw", 12:16:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:16:09 INFO - "branch": "fx-team", 12:16:09 INFO - "repo_path": "integration/fx-team", 12:16:09 INFO - "revision": "216d9ae88a315bed4961b121fb96f930411cf4b2", 12:16:09 INFO - "stage_platform": "linux64", 12:16:09 INFO - "builduid": "178b039e54474b96b36303247c1214e7", 12:16:09 INFO - "slavebuilddir": "test" 12:16:09 INFO - } 12:16:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:16:09 INFO - Running post-action listener: _resource_record_post_action 12:16:09 INFO - ##### 12:16:09 INFO - ##### Running download-and-extract step. 12:16:09 INFO - ##### 12:16:09 INFO - Running pre-action listener: _resource_record_pre_action 12:16:09 INFO - Running main action method: download_and_extract 12:16:09 INFO - mkdir: /builds/slave/test/build/tests 12:16:09 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')]} 12:16:09 INFO - https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:18 INFO - Downloaded 1361 bytes. 12:16:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:16:18 INFO - Using the following test package requirements: 12:16:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:16:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'jsshell-linux-x86_64.zip'], 12:16:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:18 INFO - https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:28 INFO - Downloaded 22000154 bytes. 12:16:28 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'] 12:16:28 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 12:16:30 INFO - Return code: 0 12:16:30 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 12:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:30 INFO - https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:39 INFO - Downloaded 22000154 bytes. 12:16:39 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'] 12:16:39 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 12:16:40 INFO - Return code: 0 12:16:40 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')]} 12:16:40 INFO - https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:52 INFO - Downloaded 10847637 bytes. 12:16:52 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'] 12:16:52 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 12:16:52 INFO - Return code: 0 12:16: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')]} 12:16:52 INFO - https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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 12:17:06 INFO - Downloaded 54169704 bytes. 12:17:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:17:06 INFO - mkdir: /builds/slave/test/properties 12:17:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:06 INFO - Contents: 12:17:06 INFO - build_url:https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:17:08 INFO - Running post-action listener: _resource_record_post_action 12:17:08 INFO - Running post-action listener: set_extra_try_arguments 12:17:08 INFO - ##### 12:17:08 INFO - ##### Running populate-webroot step. 12:17:08 INFO - ##### 12:17:08 INFO - Running pre-action listener: _resource_record_pre_action 12:17:08 INFO - Running main action method: populate_webroot 12:17:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:08 INFO - '--tppagecycles', 12:17:08 INFO - '7'], 12:17:08 INFO - 'tests': ['tsvgm']}}, 12:17:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:17:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'tests': ['damp', 'tps']}, 12:17:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['damp', 'tps']}, 12:17:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:08 INFO - 'other': {'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'other_l64': {'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:08 INFO - 'ts_paint', 12:17:08 INFO - 'tpaint', 12:17:08 INFO - 'sessionrestore', 12:17:08 INFO - 'sessionrestore_no_auto_restore', 12:17:08 INFO - 'tabpaint']}, 12:17:08 INFO - 'svgr': {'tests': ['tsvgx', 12:17:08 INFO - 'tsvgr_opacity', 12:17:08 INFO - 'tart', 12:17:08 INFO - 'tscrollx', 12:17:08 INFO - 'cart']}, 12:17:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['tsvgx', 12:17:08 INFO - 'tsvgr_opacity', 12:17:08 INFO - 'tart', 12:17:08 INFO - 'tscrollx', 12:17:08 INFO - 'cart']}, 12:17:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'tests': ['tp5o']}, 12:17:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'talos_options': ['--e10s'], 12:17:08 INFO - 'tests': ['tp5o']}, 12:17:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'talos_options': ['--xperf_path', 12:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:08 INFO - 'tests': ['tp5n']}, 12:17:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:08 INFO - 'talos_options': ['--e10s', 12:17:08 INFO - '--xperf_path', 12:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:08 INFO - 'tests': ['tp5n']}}, 12:17:08 INFO - 'talos.zip': {'path': '', 12:17:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:08 INFO - Running post-action listener: _resource_record_post_action 12:17:08 INFO - ##### 12:17:08 INFO - ##### Running create-virtualenv step. 12:17:08 INFO - ##### 12:17:08 INFO - Running pre-action listener: _resource_record_pre_action 12:17:08 INFO - Running main action method: create_virtualenv 12:17:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:08 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 12:17:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:08 INFO - Using real prefix '/usr' 12:17:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:11 INFO - Installing pip.................done. 12:17:11 INFO - Return code: 0 12:17:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:11 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:11 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 12:17:11 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 12:17:11 INFO - Using env: {'DISPLAY': ':0', 12:17:11 INFO - 'HOME': '/home/cltbld', 12:17:11 INFO - 'LANG': 'en_US.UTF-8', 12:17:11 INFO - 'LANGUAGE': 'en_US:en', 12:17:11 INFO - 'LOGNAME': 'cltbld', 12:17:11 INFO - 'MAIL': '/var/mail/cltbld', 12:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:11 INFO - 'MOZ_NO_REMOTE': '1', 12:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:11 INFO - 'NO_EM_RESTART': '1', 12:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:11 INFO - 'PWD': '/builds/slave/test', 12:17:11 INFO - 'SHELL': '/bin/bash', 12:17:11 INFO - 'SHLVL': '1', 12:17:11 INFO - 'TERM': 'linux', 12:17:11 INFO - 'TMOUT': '86400', 12:17:11 INFO - 'USER': 'cltbld', 12:17:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:11 INFO - '_': '/tools/buildbot/bin/python'} 12:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:11 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 12:17:11 INFO - Cleaning up... 12:17:11 INFO - Return code: 0 12:17:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:11 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:11 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 12:17:11 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 12:17:11 INFO - Using env: {'DISPLAY': ':0', 12:17:11 INFO - 'HOME': '/home/cltbld', 12:17:11 INFO - 'LANG': 'en_US.UTF-8', 12:17:11 INFO - 'LANGUAGE': 'en_US:en', 12:17:11 INFO - 'LOGNAME': 'cltbld', 12:17:11 INFO - 'MAIL': '/var/mail/cltbld', 12:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:11 INFO - 'MOZ_NO_REMOTE': '1', 12:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:11 INFO - 'NO_EM_RESTART': '1', 12:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:11 INFO - 'PWD': '/builds/slave/test', 12:17:11 INFO - 'SHELL': '/bin/bash', 12:17:11 INFO - 'SHLVL': '1', 12:17:11 INFO - 'TERM': 'linux', 12:17:11 INFO - 'TMOUT': '86400', 12:17:11 INFO - 'USER': 'cltbld', 12:17:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:11 INFO - '_': '/tools/buildbot/bin/python'} 12:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:11 INFO - Downloading/unpacking psutil>=0.7.1 12:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:18 INFO - Installing collected packages: psutil 12:17:18 INFO - Running setup.py install for psutil 12:17:18 INFO - building 'psutil._psutil_linux' extension 12:17:18 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 12:17:18 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 12:17:18 INFO - building 'psutil._psutil_posix' extension 12:17:18 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 12:17:18 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 12:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:18 INFO - Successfully installed psutil 12:17:18 INFO - Cleaning up... 12:17:18 INFO - Return code: 0 12:17:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:18 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 12:17:18 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 12:17:18 INFO - Using env: {'DISPLAY': ':0', 12:17:18 INFO - 'HOME': '/home/cltbld', 12:17:18 INFO - 'LANG': 'en_US.UTF-8', 12:17:18 INFO - 'LANGUAGE': 'en_US:en', 12:17:18 INFO - 'LOGNAME': 'cltbld', 12:17:18 INFO - 'MAIL': '/var/mail/cltbld', 12:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:18 INFO - 'MOZ_NO_REMOTE': '1', 12:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:18 INFO - 'NO_EM_RESTART': '1', 12:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:18 INFO - 'PWD': '/builds/slave/test', 12:17:18 INFO - 'SHELL': '/bin/bash', 12:17:18 INFO - 'SHLVL': '1', 12:17:18 INFO - 'TERM': 'linux', 12:17:18 INFO - 'TMOUT': '86400', 12:17:18 INFO - 'USER': 'cltbld', 12:17:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:18 INFO - '_': '/tools/buildbot/bin/python'} 12:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:17:25 INFO - Installing collected packages: mozsystemmonitor 12:17:25 INFO - Running setup.py install for mozsystemmonitor 12:17:25 INFO - Successfully installed mozsystemmonitor 12:17:25 INFO - Cleaning up... 12:17:25 INFO - Return code: 0 12:17:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:25 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:25 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 12:17:25 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 12:17:25 INFO - Using env: {'DISPLAY': ':0', 12:17:25 INFO - 'HOME': '/home/cltbld', 12:17:25 INFO - 'LANG': 'en_US.UTF-8', 12:17:25 INFO - 'LANGUAGE': 'en_US:en', 12:17:25 INFO - 'LOGNAME': 'cltbld', 12:17:25 INFO - 'MAIL': '/var/mail/cltbld', 12:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:25 INFO - 'MOZ_NO_REMOTE': '1', 12:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:25 INFO - 'NO_EM_RESTART': '1', 12:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:25 INFO - 'PWD': '/builds/slave/test', 12:17:25 INFO - 'SHELL': '/bin/bash', 12:17:25 INFO - 'SHLVL': '1', 12:17:25 INFO - 'TERM': 'linux', 12:17:25 INFO - 'TMOUT': '86400', 12:17:25 INFO - 'USER': 'cltbld', 12:17:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:25 INFO - '_': '/tools/buildbot/bin/python'} 12:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:25 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 12:17:25 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 12:17:25 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 12:17:25 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 12:17:25 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 12:17:25 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 12:17:30 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:32 INFO - Downloading docopt-0.6.1.tar.gz 12:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:32 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:32 INFO - Running setup.py install for blobuploader 12:17:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:32 INFO - Running setup.py install for requests 12:17:32 INFO - Running setup.py install for docopt 12:17:32 INFO - Successfully installed blobuploader requests docopt 12:17:32 INFO - Cleaning up... 12:17:33 INFO - Return code: 0 12:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:33 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:33 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 12:17:33 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 12:17:33 INFO - Using env: {'DISPLAY': ':0', 12:17:33 INFO - 'HOME': '/home/cltbld', 12:17:33 INFO - 'LANG': 'en_US.UTF-8', 12:17:33 INFO - 'LANGUAGE': 'en_US:en', 12:17:33 INFO - 'LOGNAME': 'cltbld', 12:17:33 INFO - 'MAIL': '/var/mail/cltbld', 12:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:33 INFO - 'MOZ_NO_REMOTE': '1', 12:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:33 INFO - 'NO_EM_RESTART': '1', 12:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:33 INFO - 'PWD': '/builds/slave/test', 12:17:33 INFO - 'SHELL': '/bin/bash', 12:17:33 INFO - 'SHLVL': '1', 12:17:33 INFO - 'TERM': 'linux', 12:17:33 INFO - 'TMOUT': '86400', 12:17:33 INFO - 'USER': 'cltbld', 12:17:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:33 INFO - '_': '/tools/buildbot/bin/python'} 12:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:33 INFO - Running setup.py (path:/tmp/pip-yoiHCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:33 INFO - Running setup.py (path:/tmp/pip-FpoUER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:33 INFO - Running setup.py (path:/tmp/pip-6q0Gs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:33 INFO - Running setup.py (path:/tmp/pip-K79Fkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:33 INFO - Running setup.py (path:/tmp/pip-CGzBNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:33 INFO - Running setup.py (path:/tmp/pip-aTgLo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:33 INFO - Running setup.py (path:/tmp/pip-Zvrwbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:33 INFO - Running setup.py (path:/tmp/pip-FYF_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:33 INFO - Running setup.py (path:/tmp/pip-Xh5VLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:33 INFO - Running setup.py (path:/tmp/pip-vUkzyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:33 INFO - Running setup.py (path:/tmp/pip-BWDARk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:34 INFO - Running setup.py (path:/tmp/pip-Kr6XIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:34 INFO - Running setup.py (path:/tmp/pip-sS7eUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:34 INFO - Running setup.py (path:/tmp/pip-tlhWWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:34 INFO - Running setup.py (path:/tmp/pip-udbq93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:34 INFO - Running setup.py (path:/tmp/pip-5SJfgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:34 INFO - Running setup.py (path:/tmp/pip-DW_ZOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:34 INFO - Running setup.py install for manifestparser 12:17:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for mozcrash 12:17:34 INFO - Running setup.py install for mozdebug 12:17:34 INFO - Running setup.py install for mozdevice 12:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for mozfile 12:17:34 INFO - Running setup.py install for mozhttpd 12:17:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozinfo 12:17:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozInstall 12:17:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozleak 12:17:35 INFO - Running setup.py install for mozlog 12:17:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for moznetwork 12:17:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozprocess 12:17:35 INFO - Running setup.py install for mozprofile 12:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozrunner 12:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:35 INFO - Running setup.py install for mozscreenshot 12:17:36 INFO - Running setup.py install for moztest 12:17:36 INFO - Running setup.py install for mozversion 12:17:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:36 INFO - Cleaning up... 12:17:36 INFO - Return code: 0 12:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:36 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:36 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 12:17:36 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 12:17:36 INFO - Using env: {'DISPLAY': ':0', 12:17:36 INFO - 'HOME': '/home/cltbld', 12:17:36 INFO - 'LANG': 'en_US.UTF-8', 12:17:36 INFO - 'LANGUAGE': 'en_US:en', 12:17:36 INFO - 'LOGNAME': 'cltbld', 12:17:36 INFO - 'MAIL': '/var/mail/cltbld', 12:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:36 INFO - 'MOZ_NO_REMOTE': '1', 12:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:36 INFO - 'NO_EM_RESTART': '1', 12:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:36 INFO - 'PWD': '/builds/slave/test', 12:17:36 INFO - 'SHELL': '/bin/bash', 12:17:36 INFO - 'SHLVL': '1', 12:17:36 INFO - 'TERM': 'linux', 12:17:36 INFO - 'TMOUT': '86400', 12:17:36 INFO - 'USER': 'cltbld', 12:17:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:36 INFO - '_': '/tools/buildbot/bin/python'} 12:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:36 INFO - Running setup.py (path:/tmp/pip-D3JyVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:36 INFO - Running setup.py (path:/tmp/pip-pHyAcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:36 INFO - Running setup.py (path:/tmp/pip-8DH27s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:36 INFO - Running setup.py (path:/tmp/pip-OCVTMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:36 INFO - Running setup.py (path:/tmp/pip-fQDuh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:36 INFO - Running setup.py (path:/tmp/pip-Gf54rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:36 INFO - Running setup.py (path:/tmp/pip-ed3OEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:36 INFO - Running setup.py (path:/tmp/pip-MZz4xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:36 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)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:37 INFO - Running setup.py (path:/tmp/pip-1XLiGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:37 INFO - Running setup.py (path:/tmp/pip-7wiQ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:37 INFO - Running setup.py (path:/tmp/pip-19mCnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:37 INFO - Running setup.py (path:/tmp/pip-ifSZMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:37 INFO - Running setup.py (path:/tmp/pip-Tu5g7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:37 INFO - Running setup.py (path:/tmp/pip-l6Po_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:37 INFO - Running setup.py (path:/tmp/pip-azuJ2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:37 INFO - Running setup.py (path:/tmp/pip-J8sd7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:37 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)) 12:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:37 INFO - Running setup.py (path:/tmp/pip-fsZpa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:37 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)) 12:17:37 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)) 12:17:37 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)) 12:17:37 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)) 12:17:37 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)) 12:17:37 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)) 12:17:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:40 INFO - Downloading blessings-1.6.tar.gz 12:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:40 INFO - Installing collected packages: blessings 12:17:40 INFO - Running setup.py install for blessings 12:17:41 INFO - Successfully installed blessings 12:17:41 INFO - Cleaning up... 12:17:41 INFO - Return code: 0 12:17:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:41 INFO - Reading from file tmpfile_stdout 12:17:41 INFO - Current package versions: 12:17:41 INFO - argparse == 1.2.1 12:17:41 INFO - blessings == 1.6 12:17:41 INFO - blobuploader == 1.2.4 12:17:41 INFO - docopt == 0.6.1 12:17:41 INFO - manifestparser == 1.1 12:17:41 INFO - mozInstall == 1.12 12:17:41 INFO - mozcrash == 0.17 12:17:41 INFO - mozdebug == 0.1 12:17:41 INFO - mozdevice == 0.48 12:17:41 INFO - mozfile == 1.2 12:17:41 INFO - mozhttpd == 0.7 12:17:41 INFO - mozinfo == 0.9 12:17:41 INFO - mozleak == 0.1 12:17:41 INFO - mozlog == 3.1 12:17:41 INFO - moznetwork == 0.27 12:17:41 INFO - mozprocess == 0.22 12:17:41 INFO - mozprofile == 0.28 12:17:41 INFO - mozrunner == 6.11 12:17:41 INFO - mozscreenshot == 0.1 12:17:41 INFO - mozsystemmonitor == 0.0 12:17:41 INFO - moztest == 0.7 12:17:41 INFO - mozversion == 1.4 12:17:41 INFO - psutil == 3.1.1 12:17:41 INFO - requests == 1.2.3 12:17:41 INFO - wsgiref == 0.1.2 12:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:41 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:41 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 12:17:41 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 12:17:41 INFO - Using env: {'DISPLAY': ':0', 12:17:41 INFO - 'HOME': '/home/cltbld', 12:17:41 INFO - 'LANG': 'en_US.UTF-8', 12:17:41 INFO - 'LANGUAGE': 'en_US:en', 12:17:41 INFO - 'LOGNAME': 'cltbld', 12:17:41 INFO - 'MAIL': '/var/mail/cltbld', 12:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:41 INFO - 'MOZ_NO_REMOTE': '1', 12:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:41 INFO - 'NO_EM_RESTART': '1', 12:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:41 INFO - 'PWD': '/builds/slave/test', 12:17:41 INFO - 'SHELL': '/bin/bash', 12:17:41 INFO - 'SHLVL': '1', 12:17:41 INFO - 'TERM': 'linux', 12:17:41 INFO - 'TMOUT': '86400', 12:17:41 INFO - 'USER': 'cltbld', 12:17:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:41 INFO - '_': '/tools/buildbot/bin/python'} 12:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 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)) 12:17:41 INFO - Cleaning up... 12:17:41 INFO - Return code: 0 12:17:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:17:41 INFO - Using env: {'DISPLAY': ':0', 12:17:41 INFO - 'HOME': '/home/cltbld', 12:17:41 INFO - 'LANG': 'en_US.UTF-8', 12:17:41 INFO - 'LANGUAGE': 'en_US:en', 12:17:41 INFO - 'LOGNAME': 'cltbld', 12:17:41 INFO - 'MAIL': '/var/mail/cltbld', 12:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:41 INFO - 'MOZ_NO_REMOTE': '1', 12:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:41 INFO - 'NO_EM_RESTART': '1', 12:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:41 INFO - 'PWD': '/builds/slave/test', 12:17:41 INFO - 'SHELL': '/bin/bash', 12:17:41 INFO - 'SHLVL': '1', 12:17:41 INFO - 'TERM': 'linux', 12:17:41 INFO - 'TMOUT': '86400', 12:17:41 INFO - 'USER': 'cltbld', 12:17:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:41 INFO - '_': '/tools/buildbot/bin/python'} 12:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:41 INFO - Downloading/unpacking jsonschema 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:47 INFO - Downloading/unpacking functools32 (from jsonschema) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:47 INFO - warning: no files found matching '*.txt' 12:17:47 INFO - no previously-included directories found matching 'build' 12:17:47 INFO - no previously-included directories found matching 'dist' 12:17:47 INFO - no previously-included directories found matching '.git*' 12:17:47 INFO - Installing collected packages: jsonschema, functools32 12:17:47 INFO - Running setup.py install for functools32 12:17:47 INFO - warning: no files found matching '*.txt' 12:17:47 INFO - no previously-included directories found matching 'build' 12:17:47 INFO - no previously-included directories found matching 'dist' 12:17:47 INFO - no previously-included directories found matching '.git*' 12:17:47 INFO - Successfully installed jsonschema functools32 12:17:47 INFO - Cleaning up... 12:17:47 INFO - Return code: 0 12:17:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:47 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 0x7ff969cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16425a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, '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': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', '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 12:17:47 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 12:17:47 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 12:17:47 INFO - Using env: {'DISPLAY': ':0', 12:17:47 INFO - 'HOME': '/home/cltbld', 12:17:47 INFO - 'LANG': 'en_US.UTF-8', 12:17:47 INFO - 'LANGUAGE': 'en_US:en', 12:17:47 INFO - 'LOGNAME': 'cltbld', 12:17:47 INFO - 'MAIL': '/var/mail/cltbld', 12:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:47 INFO - 'MOZ_NO_REMOTE': '1', 12:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:47 INFO - 'NO_EM_RESTART': '1', 12:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:47 INFO - 'PWD': '/builds/slave/test', 12:17:47 INFO - 'SHELL': '/bin/bash', 12:17:47 INFO - 'SHLVL': '1', 12:17:47 INFO - 'TERM': 'linux', 12:17:47 INFO - 'TMOUT': '86400', 12:17:47 INFO - 'USER': 'cltbld', 12:17:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:47 INFO - '_': '/tools/buildbot/bin/python'} 12:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:48 INFO - Downloading/unpacking flake8 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:17:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:17:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:56 INFO - no previously-included directories found matching 'docs/_build' 12:17:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:17:56 INFO - Running setup.py install for pep8 12:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:56 INFO - no previously-included directories found matching 'docs/_build' 12:17:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:17:56 INFO - Cleaning up... 12:17:56 INFO - Return code: 0 12:17:56 INFO - Running post-action listener: _resource_record_post_action 12:17:56 INFO - Running post-action listener: _start_resource_monitoring 12:17:56 INFO - Starting resource monitoring. 12:17:56 INFO - ##### 12:17:56 INFO - ##### Running install step. 12:17:56 INFO - ##### 12:17:56 INFO - Running pre-action listener: _resource_record_pre_action 12:17:56 INFO - Running main action method: install 12:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:56 INFO - Reading from file tmpfile_stdout 12:17:56 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:56 INFO - Reading from file tmpfile_stdout 12:17:56 INFO - Output received: 12:17:56 INFO - Usage: mozinstall [options] installer 12:17:56 INFO - Options: 12:17:56 INFO - -h, --help show this help message and exit 12:17:56 INFO - -d DEST, --destination=DEST 12:17:56 INFO - Directory to install application into. [default: 12:17:56 INFO - "/builds/slave/test"] 12:17:56 INFO - --app=APP Application being installed. [default: firefox] 12:17:56 INFO - mkdir: /builds/slave/test/build/application 12:17:56 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'] 12:17:56 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 12:18:12 INFO - Reading from file tmpfile_stdout 12:18:12 INFO - Output received: 12:18:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:12 INFO - Running post-action listener: _resource_record_post_action 12:18:12 INFO - ##### 12:18:12 INFO - ##### Running run-tests step. 12:18:12 INFO - ##### 12:18:12 INFO - Running pre-action listener: _resource_record_pre_action 12:18:12 INFO - Running main action method: run_tests 12:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:12 INFO - Python 2.7.3 12:18:12 INFO - Return code: 0 12:18:12 INFO - grabbing minidump binary from tooltool 12:18:12 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')]} 12:18:12 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 0x16d1410>, '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 0x16d2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:12 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 12:18:12 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 12:18:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:12 INFO - Return code: 0 12:18:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:18:13 INFO - Return code: 0 12:18:13 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/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 12:18:13 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/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 12:18:13 INFO - Using env: {'DISPLAY': ':0', 12:18:13 INFO - 'HOME': '/home/cltbld', 12:18:13 INFO - 'LANG': 'en_US.UTF-8', 12:18:13 INFO - 'LANGUAGE': 'en_US:en', 12:18:13 INFO - 'LOGNAME': 'cltbld', 12:18:13 INFO - 'MAIL': '/var/mail/cltbld', 12:18:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:13 INFO - 'MOZ_NO_REMOTE': '1', 12:18:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:13 INFO - 'NO_EM_RESTART': '1', 12:18:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:13 INFO - 'PWD': '/builds/slave/test', 12:18:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:13 INFO - 'SHELL': '/bin/bash', 12:18:13 INFO - 'SHLVL': '1', 12:18:13 INFO - 'TERM': 'linux', 12:18:13 INFO - 'TMOUT': '86400', 12:18:13 INFO - 'USER': 'cltbld', 12:18:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115', 12:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:13 INFO - '_': '/tools/buildbot/bin/python'} 12:18:13 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/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 12:18:13 INFO - mozversion application_buildid: 20160321112834 12:18:13 INFO - mozversion application_changeset: 216d9ae88a315bed4961b121fb96f930411cf4b2 12:18:13 INFO - mozversion application_display_name: Nightly 12:18:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:13 INFO - mozversion application_name: Firefox 12:18:13 INFO - mozversion application_remotingname: firefox 12:18:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:18:13 INFO - mozversion application_vendor: Mozilla 12:18:13 INFO - mozversion application_version: 48.0a1 12:18:13 INFO - mozversion platform_buildid: 20160321112834 12:18:13 INFO - mozversion platform_changeset: 216d9ae88a315bed4961b121fb96f930411cf4b2 12:18:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:18:13 INFO - mozversion platform_version: 48.0a1 12:18:13 INFO - using testdate: 1458587893 12:18:13 INFO - actual date: 1458587893 12:18:13 INFO - starting webserver on 'localhost:40404' 12:18:13 INFO - SUITE-START | Running 2 tests 12:18:13 INFO - TEST-START | dromaeo_css 12:18:13 INFO - operating with platform_type : linux_ 12:18:13 INFO - Initialising browser for dromaeo_css test... 12:18:13 INFO - TEST-INFO | started process 11831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgBblO/profile http://localhost:40404/getInfo.html) 12:18:17 INFO - PROCESS | 11831 | __metrics Screen width/height:1600/1200 12:18:17 INFO - PROCESS | 11831 | colorDepth:24 12:18:17 INFO - PROCESS | 11831 | Browser inner width/height: 1024/697 12:18:17 INFO - PROCESS | 11831 | __metrics 12:18:18 ERROR - PROCESS | 11831 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:18:19 INFO - TEST-INFO | 11831: exit 0 12:18:19 INFO - Browser initialized. 12:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:19 INFO - TEST-INFO | started process 11927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgBblO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:31 INFO - PROCESS | 11927 | RSS: Main: 157319168 12:18:31 INFO - PROCESS | 11927 | 12:19:22 INFO - PROCESS | 11927 | 1458587962595 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] 12:21:33 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40404/tests/dromaeo/cssquery-ext.html) 12:21:34 INFO - PROCESS | 11927 | RSS: Main: 233848832 12:21:34 INFO - PROCESS | 11927 | 12:24:37 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-ext.html (next: http://localhost:40404/tests/dromaeo/cssquery-jquery.html) 12:24:37 INFO - PROCESS | 11927 | RSS: Main: 239288320 12:24:37 INFO - PROCESS | 11927 | 12:27:39 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40404/tests/dromaeo/cssquery-mootools.html) 12:27:40 INFO - PROCESS | 11927 | RSS: Main: 242155520 12:27:40 INFO - PROCESS | 11927 | 12:30:42 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40404/tests/dromaeo/cssquery-prototype.html) 12:30:42 INFO - PROCESS | 11927 | RSS: Main: 207073280 12:30:42 INFO - PROCESS | 11927 | 12:33:45 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40404/tests/dromaeo/cssquery-yui.html) 12:33:45 INFO - PROCESS | 11927 | RSS: Main: 205332480 12:33:45 INFO - PROCESS | 11927 | 12:36:48 INFO - PROCESS | 11927 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-yui.html (next: http://localhost:40404/tests/dromaeo/cssquery-dojo.html) 12:36:48 INFO - PROCESS | 11927 | RSS: Main: 281759744 12:36:48 INFO - PROCESS | 11927 | 12:36:48 INFO - PROCESS | 11927 | __start_tp_report 12:36:48 INFO - PROCESS | 11927 | _x_x_mozilla_page_load 12:36:48 INFO - PROCESS | 11927 | _x_x_mozilla_page_load_details 12:36:48 INFO - PROCESS | 11927 | |i|pagename|runs| 12:36:48 INFO - PROCESS | 11927 | |0;dojo.html;2602.557565213913;2629.0798220622773;2667.7599016088548;2675.4916565852486;2677.12993277185;4513.638908887289;4607.401037865073;4621.191291523983;4666.626669866415;4698.013417182391;4604.44746630404;4614.307853821929;4662.79017444215;4669.34629151919;4692.038132182903;4247.745135291877;4254.723442976212;4270.996315865769;4305.117450922553;4322.243607368714;4302.268614335555;4358.956410435902;4384.18892504886;4393.121375724868;4397.934030989538;4173.394857745609;4247.086876321606;4278.700490965633;4300.720453170534;4351.129774045188;4252.468441444819;4262.25410553152;4272.46594175728;4291.721038132511;4310.159518893817;4230.725002874803;4233.1322078973735;4237.067845074079;4239.554846741109;4273;4421.646268298528;4524.3213517972235;4530.207213737583;4571.1771881061395;4607.285870690049;4901.558859702608;4927.211646136637;4933.851984440473;4933.975330123362;4962.578180854632;4934;4936.728479933602;4941.7034977901085;4949.381327334083;4995.325631039799;4529.365888775574;4602.7008244464005;4619.653525985565;4699.130660827758;4699.694519856198;4998.800047998112;5007.574356179765;5019.573336266459;5061.164907790247;5066.03745288394;4800.303955926371;4800.447948485899;4800.615950723934;4803.711777293373;4842.201036828884;4777.880552986134;4883.536064073907;4898;4915.311856340115;4989.525995030466;4863.197572400514;4867.123917694849;4873.366462359871;4889.755512224375;4913.164761990471;4829.420469543677;4852.223644216909;4872.049950259665;4872.4640289568115;4923.261510773341;4088.8977775555254;4147.771872547039;4152.003519155442;4158.022864626811;4191.91616167675;3648.288583726201;3675.797831119314;3702;3702;3707.4994875691978;4273.038566322614;4280.0369916769105;4284.1645879053285;4284.614384705392;4287.356896465555;4917.213245880714;4952.826651067267;4956.479569645207;4991.875203119878;5007.39911210657;4241.321388577812;4245.724027938174;4250.702450828412;4257.57424257578;4288.442502474658;4341.5007274163245;4409.470863496401;4417.514073451917;4421.159979603865;4435.600795928382;4687.671862969628;4690.108879312919;4699.506551812011;4704.082703872712;4748.6438517111355;4870.634702397405;4879.951200488092;4915.926261106015;4923.630727695366;4969.0807200668;4596.149712303235;4693.990791979604;4716.905661886812;4740.857774266778;4759;4826.01066781302;4843.1524483216;4859.149648811514;4881.975590122027;4887.535684110004;4892.339534162842;4904.411470623548;4914.213725803854;4925.088858561177;4967.379077615298;4703.129920964632;4761.523847615349;4791.544803243686;4857.732824694675;4868.3427737255015;4754.809807607795;4766.808297925519;4772.069446457907;4777.3072904429355;4824.951750482591;4710.905781884411;4712.293156026486;4718;4719.10337035962;4770.045990801784;4723.456802467623;4811.759412029314;4841.346418233635;4893.363862697969;4894.681845680019;4743.952560474351;4748.952510474989;4767.713937163781;4769.070031343994;4815 12:36:48 INFO - PROCESS | 11927 | |1;ext.html;524.0017766155476;525.6399366433993;533.2028617217261;550.7824409358302;550.7851937744283;27147.647820241793;34967.475487867705;35431.2913741725;35462.64537354626;35517.2896542069;38398;38929.80535097328;38952;38956;38984.22031559374;7647.923520764804;7808.453408261424;7830.060392752849;7830.216978302181;7836.647350869196;7658.693652253904;7779.533228006309;7784.260495252942;7787.493812902171;7944.126146123922;7924.207579242058;7992.520448773063;7997.68009279631;8003.759887203393;8009.239122283374;7874.960625196866;7939.047314322261;7950.4832185907735;7954.284114429729;7959.442839001273;7854.646540905673;7950.045994480642;7968.521888686697;7969.880451793228;7975.60121993898;37553.812230938944;38003.809980950195;38011.239775204616;38044.61955380438;38048.23903521914;3064.892728754483;3255.9023229303157;3257.723093537052;3320.369129865318;3454.3954807908767;28157;28535.429291414264;28717.13848584546;28727;28888.71111288902;3420.281740834403;3493.406120959443;3494.912627184315;3536.0629433200224;3556.9466458002894;244632;246351;246998.7650061756;247369;248683;49306.260406093934;53524.732376337866;53751.46248537464;53849;56737.43262567404;55933.40665933374;56078.15882761762;56094;56136.15795763067;56214.43785562174;12155.817662735066;12282.38588070593;12287.324197169062;12331.445084971198;12343.629691109281;8417.284530814826;9357.438553686801;9626.133647971716;9717.368371055858;9748.220142388593;18164.90917545404;18195.181216845274;18262.178201980943;18309.908450457664;18326.725099123523;6861.142357205349;7094.361507464249;7100.218975912646;7160.713571457188;7182.317679820409;858.5707146426787;899.0944692817652;984.8522721591819;996.5465713100522;1045.310095337089;27271.72728272692;27881.302967425978;27908;28258.576121358197;28336;970.2529052629436;1011.2769369900557;1044.3942513342242;1052.826283663187;1070.6979993014925;14161.85838141626;14547.709045819025;14560;14703.338349774072;14760.261986900612;297042;299245;300609;300881;301955;47566;47935.04129917452;47981.520184798406;47982;47991.28013079806;1059.0944742245424;1142.251825054574;1208.987910120905;1236.8021116621298;1243.7947738623027;24556.176039755657;25082.37294067663;25974.09090681817;26005.869970650027;27379.178624641292;38280.80859595684;38615;38686;38705.806470967465;38725.80637096796;198431;201769;202117;202125;202309;26720;30899.69100308968;31010.844945775127;31140.37719245648;31358.529622056143;37698.43452348272;39007.609923900396;39232.80383598064;39483.40774888321;39596.604033959295;33136.834315828266;33309.333813323115;34131.82934085314;34179;34519;33111.668883311824;33155.83422082874;33377.49933750947;33418.49872251869;33819;32456.188595285308;32926.17684557905;32958.34083318368;33001.83499082585;33360.332793343514;28913.7108628911;30013.399732005673;30123.246918826328;30269.091927241338;30300.090997270116;23350.53298934046;23983.400414989766;24075.6663800517;24303;24335.26994190177 12:36:48 INFO - PROCESS | 11927 | |2;jquery.html;342.67103580562645;347.08542989223395;349.50021469298906;350.2050345715227;352.6315000824139;14696.11823290602;15230.847691523082;15286.770698439532;15658.373665053385;15815;14804.703905921875;14892.106473611564;15023.774643380359;15743.448979285698;15837.524874253762;4911.066897289522;5047.873803154932;5049.823256186034;5059.367579052619;5069;4855.5872750816225;4888.902221955559;4967.230079337708;5007.674501157431;5019;4940.382452193476;4953.925691114636;4955.132851750947;4962.429320628138;4973.303737476756;4853.951460485385;4948.430930443009;4950.55445009949;5034;5040.067587496325;4860.270959356089;4864.975675121602;4869.269609558559;4874.8537543873745;4897.975510122426;11204.21570490066;11377.715557111056;11602.76794464106;11676.065914726802;11680.766384672344;1977.3079422202259;2181.945451363713;2388.581998150317;2416.673749043874;2475.7648023437746;8798.956005219998;8928.821423571557;9014.48435110301;9281;9285.35002549815;1749.912504374776;1766.240516577871;1769.7787776527935;1878.305027139967;1890.905454727272;56168;56716;57512;58205.70897145529;58292.70853645747;10168.593256269814;10173.389596624227;10252.897471025344;10298.124659403884;10435;13056.673583160496;13144.0799144059;13175.736485270241;13200.14199077057;13213.801792973112;6527.151470308924;6626.271110177877;6654.068430419745;6785.626790526569;6792.864142717217;6103.816885493442;6123.112148738497;6177.444030037318;6189.412005859436;6233.875322493524;4318.52496225415;4399.84600538986;4431.379606855043;4495.527969563149;4502.797374118172;1741.8867773594675;1770.0441761448674;1785.7946336171506;1792.9910350448165;1793.704038833578;835.5279267214005;882.1795729971188;890.8084761776249;958.4297343080856;1003.0621369019843;15790.210489475481;16031.198440078182;16242.75635865463;16279.430219942245;16712.83287167137;871.9346049046347;900.5632268349846;913.8126684029758;925.6760133953197;968.8546717992217;9035.769286358625;9412.811743765087;9448.196903263162;9538.475383853816;9545.952270238604;400418;431619;443315;444655;447205;42085.57914420878;46013.76993115013;54624.45375546273;67880;69241.65379173071;913.8172365526921;924.6255266617031;933.6638810028385;953.7281874665687;960.3373672166183;14649.92675036618;14802.555923322318;14892;14898.925505372405;15467;33006.50490242696;33186.66813331836;34157.65842341545;34460.82769586136;35263.294734105686;40415.797921010206;42914.78542607267;42935.14129717451;43185.56814431815;43458.34812477752;7094;7433.8141546461775;7476.289752473506;7480.139783924918;7520.473566850268;6248.187735594343;8755.693550725695;10208.795824083625;10921.726956826144;11185.776284474428;4833.903321933612;5957.404259574181;8652;8875.911240887508;9964.804223493227;4452.30989196675;7483.476156669199;9711.223102151953;9871.555779989774;9995.050965062033;9320.906790932275;9513.619455221713;9644.517774111408;9953.502324883872;10029.648962286285;7234.095738032746;7244.710211591478;7300.050993370828;7431.962840185981;7455.962720186364;8211.302039326723;9745.658901938681;9764.072413120743;9783.315167938175;10058.29591928558 12:36:48 INFO - PROCESS | 11927 | |3;mootools.html;1253.636445430825;1388.7361401333746;1391.735570241654;1513.2660659580108;1714.7256438969766;6983.511154219207;7143.535670181441;7160.892586611199;7162.427005839533;7189.82025449364;7016.754413595525;7219.133703955519;7222.747203847854;7225.638718064102;7234.023406840075;1912.5027492851889;2195.6706494025943;2207.9779202208015;2239.32820153954;2252.087904398721;2253.188852013274;2260.7174103237094;2262.264763951714;2264.1056782570877;2264.932052038433;2149.720536330283;2210.5910406574753;2211.756706762255;2211.7677643847405;2214.0922221889027;2165.675148727688;2180.3023032629567;2191.5835991161707;2257.7967982881455;2261.423337049042;1992.870463419873;1995.5709522452742;2000.9599808003904;2001.6697244954564;2013.6878783788536;7330.303621156035;7385.889211661829;7405.074365704287;7416.629168541552;7417.554946703215;4387.890302742425;4519.638428925711;4530.093981203772;4544.045750392422;4545.522720114406;2932.472155012097;2944.7055294470597;2983.2690990707197;3011;3096.1640357103456;911.9589618467185;924.1128516624049;927.5825878354767;936.4474959773767;962.1773383756857;9935.453550054744;9963.202943764481;9976.451295178762;10000.349977251455;10005.249606279485;4072.3077076897;4185.121124563815;4230.1539692061715;4243.27864263076;4259.787010649455;8506.957465212634;8589.48463092204;8606;8618.052014278424;8623.741287761377;3889.4554762333296;4496.3705081288645;4510.909781804346;4512.458504979423;4517.164324599959;4013.8795836124964;4108.301588729863;4114.238865809834;4118.5057793065025;4127.318992366286;3445.5348527948404;3524.4360902255517;3538.3454060998797;3561.6972557332915;3577.767445116059;1167.731421772997;1198.0894520164738;1203.1157099531838;1203.422357268516;1213.5388552350228;959.6065613098596;992.0674565908023;1161.3032180691687;1180.3861991764406;1189.4290740444635;6734.292899245606;6768.357006084512;6776.322367763283;6799.966000169968;6812;1114.331401159298;1136.8635763708407;1143.8273535588341;1163.5462169753803;1180.6930198148543;5499.312585926759;5532.640378375393;5540.806071787468;5586.581006424534;5587.469190426903;8497.702580409656;9060.184583387396;9070.27437804974;9070.319726020574;9081.45511269326;8881.24509416694;8884.067172946876;8897.199252067345;8905.243054340453;8912;6861.108055952794;6906.240313565504;6998.75504357345;7044.894326585106;7076.32774886385;6740.090087838079;6748.156480439945;6756.932430675631;6769.526133170631;6773.221079575912;7673.808154796175;7991.160928102698;8093.797655058671;8163.306118979715;8163.959180204061;8129.75610731679;8257.133001034805;8295.04606970182;8306.127856575215;8429.662813487637;6002.519798416029;6044.486218671286;6106.572539922163;6133.938660613337;6139.079138129317;6862.897056544256;6866.313368663294;6875.243723190345;6903.827404314932;6939.132608423947;6247.781327653511;6408.231012278557;6422.839429014312;6449.4840412765925;6514.315996820265;6209.627422354673;6224.813255602339;6276.713273778956;6321.715522801577;6410.45511131559;6488.870222595428;6499.0901273820755;6558.245801732862;6559.6064236145985;6562.80311590653;6045.969770151121;6053.364396738279;6104.901117798839;6109.20580324555;6113.5414843886;6129.295131059986;6157.72290246931;6160.537959653134;6211.534134939807;6215.409536094064 12:36:49 INFO - PROCESS | 11927 | |4;prototype.html;301.1627675063325;301.6787121715373;302.7744330473797;303.82226397557423;306.5417201284081;5180.740962951856;5223.320968274119;5232.2674825524455;5289.8942021159555;5293.364796224454;5090.847274581768;5127.564157046656;5160.432352441228;5160.870978225536;5179.766910489027;3885.630865067814;4000.719949603529;4100.507939047318;4102.507699076115;4111.033907031845;4116;4119.217348703752;4119.423280740699;4133.090720041586;4142.647874930634;4080.8163632636456;4091.8772436826794;4094.672426205911;4097.446844675976;4108.548059713429;3906.9023274418223;3984.6613037891816;4083.4895638045246;4100.282450571153;4109.568495308009;3612.9638703613155;3614.34941710492;3617.6744093031753;3620.583632882226;3632.763870348419;5074.416442109131;5075.365579302587;5085.491450854922;5086.491350864921;5099.23511473282;4722.527747225285;4732.100900828831;4733.834315798965;4740.051989602093;4742.478327383985;5497.45025497451;5516.586256030773;5519.199716041192;5523.530499907512;5523.558115350762;3962.6829853611644;3967.0082479380153;3968.6229808168177;3969.0871099646956;3969.106950936045;5560.443955604448;5747.540196784247;5788.453080644503;5807.419258074201;5837.50381217597;3886.281038007921;3890.105275786528;3907.492026036654;3908.3746600543777;3915.686745060388;3936.1340505088833;3970.7419017763755;3973;3973.8609148679657;3974.066094467798;4595.080983803253;4595.563421474954;4595.678302518859;4596.2875754257475;4607.9308810367875;5546.195801608744;5548.72256387179;5556.222128901957;5558.499735023867;5558.916616250759;1381.3576686840465;1388.9236092015037;1390.652336915771;1391.0957877379583;1391.6590435343405;878.5607196401799;912.4844462878452;946.8721722567366;959.836827739286;966.0532677975623;4816.373871396766;4898.804047838046;4918.754062296871;4925.852224433273;4929.260610908321;5736.397678243808;5813.5349172066135;5818.6217895836635;5822.534197264209;5823.272090988627;4931.3589233399425;4959.628027897922;4967.05625931072;4967.776450059756;4971.105201063843;3025.9848700756356;3090.876364945377;3091.366269914662;3094.164575564585;3098.9535156972665;5473.507384335429;5475.06923822951;5481.205225242397;5481.369642491085;5488.615796894179;5667.263255776723;5910.379410161957;5929.644221346733;5950.19672344228;5952.345242023374;5458.372287186945;5461.781528738886;5474.972625136928;5481.835544933659;5482.013237617267;5778.797742079007;5779.768809247583;5789.2763404574425;5790.449907258803;5791.7683292667825;5653.886922261449;5656.830295091154;5681.659100453986;5683.658980461186;5688.061469857427;5469.808556700656;5475.123980163155;5477.780888764405;5480.040992826319;5480.808171713971;3957.5053118360206;4037.354023356249;4121.835126594902;4130.483689538808;4134.875953721393;5716.256886604715;5736.225609542826;5738.139279108;5740.425957404394;5742.253507044057;5536.169574563848;5537.667739935617;5538.975289571442;5544.085225937675;5551.25058117149;5512.972435137959;5521.309836270466;5527.50252477279;5538.639988400902;5543.196236545759;5431.9185212221055;5434.538064264581;5436.0758671026815;5438.320209973754;5446.400895901527;5346.8395948121615;5562.443755624567;5569.10894256917;5574.860628484158;5575.832725018256;5409.756560954688;5434.782608695607;5437.8368648940595;5439.755211015435;5440.292761940922 12:36:49 INFO - PROCESS | 11927 | |5;yui.html;670.3095811314346;676.6718141701275;701.5580184483774;757.9014728085344;771.1016665584594;11758.470868810902;11871.52513899444;11876.228045177057;11883.643490695282;11883.821742673867;12106.939465302683;12145.939270303657;12163.939180304085;12168.209066410676;12173.45219465124;623.6912728199525;763.0233301374222;769.86142494351;786.5909726941986;787.9093904201033;770.214381331042;771.2210667226115;772.5712229712507;774.6862520679106;776.4952780692566;831.5343407691712;831.767105210539;832.2634468495395;832.3216578488543;832.4464231286188;650.6453982579505;786.7049856303886;788.5938741548078;789.6249281591256;790.5612385126252;585.4379795396425;586.0359708279898;586.3462239602854;586.5014737473114;587.3979171349358;11425.371604561746;11490.655280341603;11497.827532587018;11503;11507.482163302671;11557.19099663024;11873.762524749456;11961.88038119625;12514.741519583178;12701.618951431472;9914.900850991542;10053;10081.89918100817;10196.490175491195;10246.18030557561;3334.733221342287;3335.282914173464;3376.6285708572036;3466.1507930556922;3472.0451875734125;44802.10395792066;45016;45191.322130168075;45293.77353113213;45638.77180614076;9603.37578057424;9749.31754777173;9792.510374481248;9794.559244834;9800.313978021613;17036.06301653396;17045.31818727262;17053.829461705223;17065.82934170667;17068.658626827393;6673.432758215509;6824.829379265558;6834.316568343126;6906.585604863724;6930.099087118642;3679.5952445231005;3766.1714422826935;3800.3539398302355;3841.673457756122;3843.2505661395758;2812.8452935088358;2884.048264072851;2909.738123568889;2927.5315949447986;2941.2205765472168;473.56195519144654;569.6268943841791;582.0309185206668;585.7042193692158;589.5107061139244;560.9158626206101;564.8672561947939;578.4620303118056;581.1805354450289;587.4184557288254;7212.531185472927;7380.557166570023;7518.323350898446;7607.9239207608325;7652.69389224436;525.9289995850588;543.6330476928058;552.0835413214046;565.3893794701712;568.1534513574826;3587.712982961357;3677.9632203678157;3740.36413809653;3847.6921846252235;3854.1713531590844;48865;49018.26472602914;49102.26346604804;49841.25238121431;50069;44507.55492445034;44573;45164.77417612891;45543.08913821705;45915.081698365844;40787.59212407838;41164.58835411668;41436.792816035726;41533.584664153575;41635.37546936798;8037.7588672339925;8234.135415781257;8240.258376746122;8713.825723485621;8717.738467845975;30593.694063059083;31324.843375782973;32589.511157333134;33537.66462335443;34170.31659366848;38969.2206155881;39275.803620981715;39765;39933.60066399415;40054.79972600235;10537.57849686004;10618.681439556825;10654.264245273043;10933.070688991525;10988.560457581607;11113.666590002313;11508.654740357802;11733.237339572901;12035.939820301193;12181.75636487283;10372.325798823053;10569.524371403151;10571.577136914437;10674.679759607225;10688.412137332522;11013.174011948975;11227.71930701739;11718.121140914294;11803.82294265604;11838.408079596158;10690.893091069302;10781;11144.721381965515;11256.549738010388;11263.774724505627;9222.40054396462;9497.335186536877;9531.809363812823;9755.853662194932;9959.350602296125;9609.711708648752;9644.373115747454;9671.854922176313;9674.85487717699;9693.660721874701 12:36:49 INFO - PROCESS | 11927 | __end_tp_report 12:36:49 INFO - PROCESS | 11927 | __start_cc_report 12:36:49 INFO - PROCESS | 11927 | _x_x_mozilla_cycle_collect,1012 12:36:49 INFO - PROCESS | 11927 | __end_cc_report 12:36:49 INFO - PROCESS | 11927 | __startTimestamp1458589008989__endTimestamp 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | ------- Summary: start ------- 12:36:49 INFO - PROCESS | 11927 | Number of tests: 6 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#0] dojo.html Cycles:165 Average:4564.66 Median:4710.91 stddev:458.65 (9.7%) stddev-sans-first:433.46 12:36:49 INFO - PROCESS | 11927 | Values: 2602.6 2629.1 2667.8 2675.5 2677.1 4513.6 4607.4 4621.2 4666.6 4698.0 4604.4 4614.3 4662.8 4669.3 4692.0 4247.7 4254.7 4271.0 4305.1 4322.2 4302.3 4359.0 4384.2 4393.1 4397.9 4173.4 4247.1 4278.7 4300.7 4351.1 4252.5 4262.3 4272.5 4291.7 4310.2 4230.7 4233.1 4237.1 4239.6 4273.0 4421.6 4524.3 4530.2 4571.2 4607.3 4901.6 4927.2 4933.9 4934.0 4962.6 4934.0 4936.7 4941.7 4949.4 4995.3 4529.4 4602.7 4619.7 4699.1 4699.7 4998.8 5007.6 5019.6 5061.2 5066.0 4800.3 4800.4 4800.6 4803.7 4842.2 4777.9 4883.5 4898.0 4915.3 4989.5 4863.2 4867.1 4873.4 4889.8 4913.2 4829.4 4852.2 4872.0 4872.5 4923.3 4088.9 4147.8 4152.0 4158.0 4191.9 3648.3 3675.8 3702.0 3702.0 3707.5 4273.0 4280.0 4284.2 4284.6 4287.4 4917.2 4952.8 4956.5 4991.9 5007.4 4241.3 4245.7 4250.7 4257.6 4288.4 4341.5 4409.5 4417.5 4421.2 4435.6 4687.7 4690.1 4699.5 4704.1 4748.6 4870.6 4880.0 4915.9 4923.6 4969.1 4596.1 4694.0 4716.9 4740.9 4759.0 4826.0 4843.2 4859.1 4882.0 4887.5 4892.3 4904.4 4914.2 4925.1 4967.4 4703.1 4761.5 4791.5 4857.7 4868.3 4754.8 4766.8 4772.1 4777.3 4825.0 4710.9 4712.3 4718.0 4719.1 4770.0 4723.5 4811.8 4841.3 4893.4 4894.7 4744.0 4749.0 4767.7 4769.1 4815.0 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#1] ext.html Cycles:180 Average:40881.27 Median:18986.70 stddev:65978.42 (347.5%) stddev-sans-first:66093.92 12:36:49 INFO - PROCESS | 11927 | Values: 524.0 525.6 533.2 550.8 550.8 27147.6 34967.5 35431.3 35462.6 35517.3 38398.0 38929.8 38952.0 38956.0 38984.2 7647.9 7808.5 7830.1 7830.2 7836.6 7658.7 7779.5 7784.3 7787.5 7944.1 7924.2 7992.5 7997.7 8003.8 8009.2 7875.0 7939.0 7950.5 7954.3 7959.4 7854.6 7950.0 7968.5 7969.9 7975.6 37553.8 38003.8 38011.2 38044.6 38048.2 3064.9 3255.9 3257.7 3320.4 3454.4 28157.0 28535.4 28717.1 28727.0 28888.7 3420.3 3493.4 3494.9 3536.1 3556.9 244632.0 246351.0 246998.8 247369.0 248683.0 49306.3 53524.7 53751.5 53849.0 56737.4 55933.4 56078.2 56094.0 56136.2 56214.4 12155.8 12282.4 12287.3 12331.4 12343.6 8417.3 9357.4 9626.1 9717.4 9748.2 18164.9 18195.2 18262.2 18309.9 18326.7 6861.1 7094.4 7100.2 7160.7 7182.3 858.6 899.1 984.9 996.5 1045.3 27271.7 27881.3 27908.0 28258.6 28336.0 970.3 1011.3 1044.4 1052.8 1070.7 14161.9 14547.7 14560.0 14703.3 14760.3 297042.0 299245.0 300609.0 300881.0 301955.0 47566.0 47935.0 47981.5 47982.0 47991.3 1059.1 1142.3 1209.0 1236.8 1243.8 24556.2 25082.4 25974.1 26005.9 27379.2 38280.8 38615.0 38686.0 38705.8 38725.8 198431.0 201769.0 202117.0 202125.0 202309.0 26720.0 30899.7 31010.8 31140.4 31358.5 37698.4 39007.6 39232.8 39483.4 39596.6 33136.8 33309.3 34131.8 34179.0 34519.0 33111.7 33155.8 33377.5 33418.5 33819.0 32456.2 32926.2 32958.3 33001.8 33360.3 28913.7 30013.4 30123.2 30269.1 30300.1 23350.5 23983.4 24075.7 24303.0 24335.3 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#2] jquery.html Cycles:180 Average:23581.29 Median:4881.88 stddev:70902.54 (1452.4%) stddev-sans-first:71079.97 12:36:49 INFO - PROCESS | 11927 | Values: 342.7 347.1 349.5 350.2 352.6 14696.1 15230.8 15286.8 15658.4 15815.0 14804.7 14892.1 15023.8 15743.4 15837.5 4911.1 5047.9 5049.8 5059.4 5069.0 4855.6 4888.9 4967.2 5007.7 5019.0 4940.4 4953.9 4955.1 4962.4 4973.3 4854.0 4948.4 4950.6 5034.0 5040.1 4860.3 4865.0 4869.3 4874.9 4898.0 11204.2 11377.7 11602.8 11676.1 11680.8 1977.3 2181.9 2388.6 2416.7 2475.8 8799.0 8928.8 9014.5 9281.0 9285.4 1749.9 1766.2 1769.8 1878.3 1890.9 56168.0 56716.0 57512.0 58205.7 58292.7 10168.6 10173.4 10252.9 10298.1 10435.0 13056.7 13144.1 13175.7 13200.1 13213.8 6527.2 6626.3 6654.1 6785.6 6792.9 6103.8 6123.1 6177.4 6189.4 6233.9 4318.5 4399.8 4431.4 4495.5 4502.8 1741.9 1770.0 1785.8 1793.0 1793.7 835.5 882.2 890.8 958.4 1003.1 15790.2 16031.2 16242.8 16279.4 16712.8 871.9 900.6 913.8 925.7 968.9 9035.8 9412.8 9448.2 9538.5 9546.0 400418.0 431619.0 443315.0 444655.0 447205.0 42085.6 46013.8 54624.5 67880.0 69241.7 913.8 924.6 933.7 953.7 960.3 14649.9 14802.6 14892.0 14898.9 15467.0 33006.5 33186.7 34157.7 34460.8 35263.3 40415.8 42914.8 42935.1 43185.6 43458.3 7094.0 7433.8 7476.3 7480.1 7520.5 6248.2 8755.7 10208.8 10921.7 11185.8 4833.9 5957.4 8652.0 8875.9 9964.8 4452.3 7483.5 9711.2 9871.6 9995.1 9320.9 9513.6 9644.5 9953.5 10029.6 7234.1 7244.7 7300.1 7432.0 7456.0 8211.3 9745.7 9764.1 9783.3 10058.3 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#3] mootools.html Cycles:180 Average:5147.73 Median:6148.40 stddev:2635.86 (42.9%) stddev-sans-first:2627.00 12:36:49 INFO - PROCESS | 11927 | Values: 1253.6 1388.7 1391.7 1513.3 1714.7 6983.5 7143.5 7160.9 7162.4 7189.8 7016.8 7219.1 7222.7 7225.6 7234.0 1912.5 2195.7 2208.0 2239.3 2252.1 2253.2 2260.7 2262.3 2264.1 2264.9 2149.7 2210.6 2211.8 2211.8 2214.1 2165.7 2180.3 2191.6 2257.8 2261.4 1992.9 1995.6 2001.0 2001.7 2013.7 7330.3 7385.9 7405.1 7416.6 7417.6 4387.9 4519.6 4530.1 4544.0 4545.5 2932.5 2944.7 2983.3 3011.0 3096.2 912.0 924.1 927.6 936.4 962.2 9935.5 9963.2 9976.5 10000.3 10005.2 4072.3 4185.1 4230.2 4243.3 4259.8 8507.0 8589.5 8606.0 8618.1 8623.7 3889.5 4496.4 4510.9 4512.5 4517.2 4013.9 4108.3 4114.2 4118.5 4127.3 3445.5 3524.4 3538.3 3561.7 3577.8 1167.7 1198.1 1203.1 1203.4 1213.5 959.6 992.1 1161.3 1180.4 1189.4 6734.3 6768.4 6776.3 6800.0 6812.0 1114.3 1136.9 1143.8 1163.5 1180.7 5499.3 5532.6 5540.8 5586.6 5587.5 8497.7 9060.2 9070.3 9070.3 9081.5 8881.2 8884.1 8897.2 8905.2 8912.0 6861.1 6906.2 6998.8 7044.9 7076.3 6740.1 6748.2 6756.9 6769.5 6773.2 7673.8 7991.2 8093.8 8163.3 8164.0 8129.8 8257.1 8295.0 8306.1 8429.7 6002.5 6044.5 6106.6 6133.9 6139.1 6862.9 6866.3 6875.2 6903.8 6939.1 6247.8 6408.2 6422.8 6449.5 6514.3 6209.6 6224.8 6276.7 6321.7 6410.5 6488.9 6499.1 6558.2 6559.6 6562.8 6046.0 6053.4 6104.9 6109.2 6113.5 6129.3 6157.7 6160.5 6211.5 6215.4 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#4] prototype.html Cycles:180 Average:4605.16 Median:5202.03 stddev:1354.83 (26.0%) stddev-sans-first:1319.55 12:36:49 INFO - PROCESS | 11927 | Values: 301.2 301.7 302.8 303.8 306.5 5180.7 5223.3 5232.3 5289.9 5293.4 5090.8 5127.6 5160.4 5160.9 5179.8 3885.6 4000.7 4100.5 4102.5 4111.0 4116.0 4119.2 4119.4 4133.1 4142.6 4080.8 4091.9 4094.7 4097.4 4108.5 3906.9 3984.7 4083.5 4100.3 4109.6 3613.0 3614.3 3617.7 3620.6 3632.8 5074.4 5075.4 5085.5 5086.5 5099.2 4722.5 4732.1 4733.8 4740.1 4742.5 5497.5 5516.6 5519.2 5523.5 5523.6 3962.7 3967.0 3968.6 3969.1 3969.1 5560.4 5747.5 5788.5 5807.4 5837.5 3886.3 3890.1 3907.5 3908.4 3915.7 3936.1 3970.7 3973.0 3973.9 3974.1 4595.1 4595.6 4595.7 4596.3 4607.9 5546.2 5548.7 5556.2 5558.5 5558.9 1381.4 1388.9 1390.7 1391.1 1391.7 878.6 912.5 946.9 959.8 966.1 4816.4 4898.8 4918.8 4925.9 4929.3 5736.4 5813.5 5818.6 5822.5 5823.3 4931.4 4959.6 4967.1 4967.8 4971.1 3026.0 3090.9 3091.4 3094.2 3099.0 5473.5 5475.1 5481.2 5481.4 5488.6 5667.3 5910.4 5929.6 5950.2 5952.3 5458.4 5461.8 5475.0 5481.8 5482.0 5778.8 5779.8 5789.3 5790.4 5791.8 5653.9 5656.8 5681.7 5683.7 5688.1 5469.8 5475.1 5477.8 5480.0 5480.8 3957.5 4037.4 4121.8 4130.5 4134.9 5716.3 5736.2 5738.1 5740.4 5742.3 5536.2 5537.7 5539.0 5544.1 5551.3 5513.0 5521.3 5527.5 5538.6 5543.2 5431.9 5434.5 5436.1 5438.3 5446.4 5346.8 5562.4 5569.1 5574.9 5575.8 5409.8 5434.8 5437.8 5439.8 5440.3 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - PROCESS | 11927 | [#5] yui.html Cycles:180 Average:12639.71 Median:44687.55 stddev:14163.65 (31.7%) stddev-sans-first:14174.86 12:36:49 INFO - PROCESS | 11927 | Values: 670.3 676.7 701.6 757.9 771.1 11758.5 11871.5 11876.2 11883.6 11883.8 12106.9 12145.9 12163.9 12168.2 12173.5 623.7 763.0 769.9 786.6 787.9 770.2 771.2 772.6 774.7 776.5 831.5 831.8 832.3 832.3 832.4 650.6 786.7 788.6 789.6 790.6 585.4 586.0 586.3 586.5 587.4 11425.4 11490.7 11497.8 11503.0 11507.5 11557.2 11873.8 11961.9 12514.7 12701.6 9914.9 10053.0 10081.9 10196.5 10246.2 3334.7 3335.3 3376.6 3466.2 3472.0 44802.1 45016.0 45191.3 45293.8 45638.8 9603.4 9749.3 9792.5 9794.6 9800.3 17036.1 17045.3 17053.8 17065.8 17068.7 6673.4 6824.8 6834.3 6906.6 6930.1 3679.6 3766.2 3800.4 3841.7 3843.3 2812.8 2884.0 2909.7 2927.5 2941.2 473.6 569.6 582.0 585.7 589.5 560.9 564.9 578.5 581.2 587.4 7212.5 7380.6 7518.3 7607.9 7652.7 525.9 543.6 552.1 565.4 568.2 3587.7 3678.0 3740.4 3847.7 3854.2 48865.0 49018.3 49102.3 49841.3 50069.0 44507.6 44573.0 45164.8 45543.1 45915.1 40787.6 41164.6 41436.8 41533.6 41635.4 8037.8 8234.1 8240.3 8713.8 8717.7 30593.7 31324.8 32589.5 33537.7 34170.3 38969.2 39275.8 39765.0 39933.6 40054.8 10537.6 10618.7 10654.3 10933.1 10988.6 11113.7 11508.7 11733.2 12035.9 12181.8 10372.3 10569.5 10571.6 10674.7 10688.4 11013.2 11227.7 11718.1 11803.8 11838.4 10690.9 10781.0 11144.7 11256.5 11263.8 9222.4 9497.3 9531.8 9755.9 9959.4 9609.7 9644.4 9671.9 9674.9 9693.7 12:36:49 INFO - PROCESS | 11927 | -------- Summary: end -------- 12:36:49 INFO - PROCESS | 11927 | 12:36:49 INFO - TEST-INFO | 11927: exit 0 12:36:49 INFO - TEST-OK | dromaeo_css | took 1115946ms 12:36:49 INFO - TEST-START | kraken 12:36:49 INFO - operating with platform_type : linux_ 12:36:49 INFO - Initialising browser for kraken test... 12:36:49 INFO - TEST-INFO | started process 12106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnZOOp/profile http://localhost:40404/getInfo.html) 12:36:53 INFO - PROCESS | 12106 | __metrics Screen width/height:1600/1200 12:36:53 INFO - PROCESS | 12106 | colorDepth:24 12:36:53 INFO - PROCESS | 12106 | Browser inner width/height: 1024/697 12:36:53 INFO - PROCESS | 12106 | __metrics 12:36:54 ERROR - PROCESS | 12106 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:36:54 INFO - PROCESS | 12106 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:36:55 INFO - TEST-INFO | 12106: exit 0 12:36:55 INFO - Browser initialized. 12:36:55 INFO - Running cycle 1/1 for kraken test... 12:36:55 INFO - TEST-INFO | started process 12187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnZOOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:07 INFO - PROCESS | 12187 | RSS: Main: 157331456 12:37:07 INFO - PROCESS | 12187 | 12:37:10 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:10 INFO - PROCESS | 12187 | RSS: Main: 200359936 12:37:10 INFO - PROCESS | 12187 | 12:37:13 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-dft) 12:37:14 INFO - PROCESS | 12187 | RSS: Main: 187641856 12:37:14 INFO - PROCESS | 12187 | 12:37:17 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-fft) 12:37:17 INFO - PROCESS | 12187 | RSS: Main: 174702592 12:37:17 INFO - PROCESS | 12187 | 12:37:19 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator) 12:37:20 INFO - PROCESS | 12187 | RSS: Main: 174497792 12:37:20 INFO - PROCESS | 12187 | 12:37:22 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:23 INFO - PROCESS | 12187 | RSS: Main: 177418240 12:37:23 INFO - PROCESS | 12187 | 12:37:26 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:26 INFO - PROCESS | 12187 | RSS: Main: 177418240 12:37:26 INFO - PROCESS | 12187 | 12:37:30 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:30 INFO - PROCESS | 12187 | RSS: Main: 177389568 12:37:30 INFO - PROCESS | 12187 | 12:37:33 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial) 12:37:34 INFO - PROCESS | 12187 | RSS: Main: 178900992 12:37:34 INFO - PROCESS | 12187 | 12:37:36 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:36 INFO - PROCESS | 12187 | RSS: Main: 190988288 12:37:36 INFO - PROCESS | 12187 | 12:37:38 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:39 INFO - PROCESS | 12187 | RSS: Main: 186527744 12:37:39 INFO - PROCESS | 12187 | 12:37:41 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:41 INFO - PROCESS | 12187 | RSS: Main: 199811072 12:37:41 INFO - PROCESS | 12187 | 12:37:44 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:44 INFO - PROCESS | 12187 | RSS: Main: 203235328 12:37:44 INFO - PROCESS | 12187 | 12:37:47 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:48 INFO - PROCESS | 12187 | RSS: Main: 203632640 12:37:48 INFO - PROCESS | 12187 | 12:37:49 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40404/tests/kraken/driver.html?testName=ai-astar) 12:37:50 INFO - PROCESS | 12187 | RSS: Main: 261935104 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | __start_tp_report 12:37:50 INFO - PROCESS | 12187 | _x_x_mozilla_page_load 12:37:50 INFO - PROCESS | 12187 | _x_x_mozilla_page_load_details 12:37:50 INFO - PROCESS | 12187 | |i|pagename|runs| 12:37:50 INFO - PROCESS | 12187 | |0;ai-astar;111;112;107;111;113;112;102;111;112;111 12:37:50 INFO - PROCESS | 12187 | |1;audio-beat-detection;157;129;156;173;137;153;163;133;172;128 12:37:50 INFO - PROCESS | 12187 | |2;audio-dft;160;162;161;160;160;161;161;161;162;161 12:37:50 INFO - PROCESS | 12187 | |3;audio-fft;77;74;97;96;73;72;73;118;92;73 12:37:50 INFO - PROCESS | 12187 | |4;audio-oscillator;93;93;142;94;94;95;139;93;94;141 12:37:50 INFO - PROCESS | 12187 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 12:37:50 INFO - PROCESS | 12187 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;146 12:37:50 INFO - PROCESS | 12187 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;95;95 12:37:50 INFO - PROCESS | 12187 | |8;json-parse-financial;68;68;69;67;69;69;69;79;67;65 12:37:50 INFO - PROCESS | 12187 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;64;64;64 12:37:50 INFO - PROCESS | 12187 | |10;stanford-crypto-aes;82;82;81;81;82;81;82;80;82;80 12:37:50 INFO - PROCESS | 12187 | |11;stanford-crypto-ccm;124;117;123;121;121;118;120;123;124;118 12:37:50 INFO - PROCESS | 12187 | |12;stanford-crypto-pbkdf2;140;142;146;141;142;134;147;151;139;140 12:37:50 INFO - PROCESS | 12187 | |13;stanford-crypto-sha256-iterative;66;68;68;66;67;67;67;67;71;65 12:37:50 INFO - PROCESS | 12187 | __end_tp_report 12:37:50 INFO - PROCESS | 12187 | __start_cc_report 12:37:50 INFO - PROCESS | 12187 | _x_x_mozilla_cycle_collect,1151 12:37:50 INFO - PROCESS | 12187 | __end_cc_report 12:37:50 INFO - PROCESS | 12187 | __startTimestamp1458589070136__endTimestamp 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | ------- Summary: start ------- 12:37:50 INFO - PROCESS | 12187 | Number of tests: 14 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.29 (3.0%) stddev-sans-first:3.48 12:37:50 INFO - PROCESS | 12187 | Values: 111.0 112.0 107.0 111.0 113.0 112.0 102.0 111.0 112.0 111.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:156.50 stddev:17.19 (11.0%) stddev-sans-first:18.05 12:37:50 INFO - PROCESS | 12187 | Values: 157.0 129.0 156.0 173.0 137.0 153.0 163.0 133.0 172.0 128.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 12:37:50 INFO - PROCESS | 12187 | Values: 160.0 162.0 161.0 160.0 160.0 161.0 161.0 161.0 162.0 161.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.50 stddev:15.59 (20.6%) stddev-sans-first:16.29 12:37:50 INFO - PROCESS | 12187 | Values: 77.0 74.0 97.0 96.0 73.0 72.0 73.0 118.0 92.0 73.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.50 stddev:22.70 (24.3%) stddev-sans-first:23.44 12:37:50 INFO - PROCESS | 12187 | Values: 93.0 93.0 142.0 94.0 94.0 95.0 139.0 93.0 94.0 141.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:37:50 INFO - PROCESS | 12187 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 12:37:50 INFO - PROCESS | 12187 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:37:50 INFO - PROCESS | 12187 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.00 stddev:3.74 (5.4%) stddev-sans-first:3.95 12:37:50 INFO - PROCESS | 12187 | Values: 68.0 68.0 69.0 67.0 69.0 69.0 69.0 79.0 67.0 65.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 12:37:50 INFO - PROCESS | 12187 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 12:37:50 INFO - PROCESS | 12187 | Values: 82.0 82.0 81.0 81.0 82.0 81.0 82.0 80.0 82.0 80.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:122.00 stddev:2.60 (2.1%) stddev-sans-first:2.51 12:37:50 INFO - PROCESS | 12187 | Values: 124.0 117.0 123.0 121.0 121.0 118.0 120.0 123.0 124.0 118.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:142.00 stddev:4.76 (3.3%) stddev-sans-first:4.98 12:37:50 INFO - PROCESS | 12187 | Values: 140.0 142.0 146.0 141.0 142.0 134.0 147.0 151.0 139.0 140.0 12:37:50 INFO - PROCESS | 12187 | 12:37:50 INFO - PROCESS | 12187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.66 12:37:50 INFO - PROCESS | 12187 | Values: 66.0 68.0 68.0 66.0 67.0 67.0 67.0 67.0 71.0 65.0 12:37:50 INFO - PROCESS | 12187 | -------- Summary: end -------- 12:37:50 INFO - PROCESS | 12187 | 12:37:51 INFO - TEST-INFO | 12187: exit 0 12:37:51 INFO - TEST-OK | kraken | took 61426ms 12:37:51 INFO - SUITE-END | took 1177s 12:37:51 INFO - Completed test suite (00:19:37) 12:37:51 INFO - javascript benchmark 12:37:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.557565213913, 2629.0798220622773, 2667.7599016088548, 2675.4916565852486, 2677.12993277185, 4513.638908887289, 4607.401037865073, 4621.191291523983, 4666.626669866415, 4698.013417182391, 4604.44746630404, 4614.307853821929, 4662.79017444215, 4669.34629151919, 4692.038132182903, 4247.745135291877, 4254.723442976212, 4270.996315865769, 4305.117450922553, 4322.243607368714, 4302.268614335555, 4358.956410435902, 4384.18892504886, 4393.121375724868, 4397.934030989538, 4173.394857745609, 4247.086876321606, 4278.700490965633, 4300.720453170534, 4351.129774045188, 4252.468441444819, 4262.25410553152, 4272.46594175728, 4291.721038132511, 4310.159518893817, 4230.725002874803, 4233.1322078973735, 4237.067845074079, 4239.554846741109, 4273.0, 4421.646268298528, 4524.3213517972235, 4530.207213737583, 4571.1771881061395, 4607.285870690049, 4901.558859702608, 4927.211646136637, 4933.851984440473, 4933.975330123362, 4962.578180854632, 4934.0, 4936.728479933602, 4941.7034977901085, 4949.381327334083, 4995.325631039799, 4529.365888775574, 4602.7008244464005, 4619.653525985565, 4699.130660827758, 4699.694519856198, 4998.800047998112, 5007.574356179765, 5019.573336266459, 5061.164907790247, 5066.03745288394, 4800.303955926371, 4800.447948485899, 4800.615950723934, 4803.711777293373, 4842.201036828884, 4777.880552986134, 4883.536064073907, 4898.0, 4915.311856340115, 4989.525995030466, 4863.197572400514, 4867.123917694849, 4873.366462359871, 4889.755512224375, 4913.164761990471, 4829.420469543677, 4852.223644216909, 4872.049950259665, 4872.4640289568115, 4923.261510773341, 4088.8977775555254, 4147.771872547039, 4152.003519155442, 4158.022864626811, 4191.91616167675, 3648.288583726201, 3675.797831119314, 3702.0, 3702.0, 3707.4994875691978, 4273.038566322614, 4280.0369916769105, 4284.1645879053285, 4284.614384705392, 4287.356896465555, 4917.213245880714, 4952.826651067267, 4956.479569645207, 4991.875203119878, 5007.39911210657, 4241.321388577812, 4245.724027938174, 4250.702450828412, 4257.57424257578, 4288.442502474658, 4341.5007274163245, 4409.470863496401, 4417.514073451917, 4421.159979603865, 4435.600795928382, 4687.671862969628, 4690.108879312919, 4699.506551812011, 4704.082703872712, 4748.6438517111355, 4870.634702397405, 4879.951200488092, 4915.926261106015, 4923.630727695366, 4969.0807200668, 4596.149712303235, 4693.990791979604, 4716.905661886812, 4740.857774266778, 4759.0, 4826.01066781302, 4843.1524483216, 4859.149648811514, 4881.975590122027, 4887.535684110004, 4892.339534162842, 4904.411470623548, 4914.213725803854, 4925.088858561177, 4967.379077615298, 4703.129920964632, 4761.523847615349, 4791.544803243686, 4857.732824694675, 4868.3427737255015, 4754.809807607795, 4766.808297925519, 4772.069446457907, 4777.3072904429355, 4824.951750482591, 4710.905781884411, 4712.293156026486, 4718.0, 4719.10337035962, 4770.045990801784, 4723.456802467623, 4811.759412029314, 4841.346418233635, 4893.363862697969, 4894.681845680019, 4743.952560474351, 4748.952510474989, 4767.713937163781, 4769.070031343994, 4815.0], "unit": "score", "name": "dojo.html", "value": 4536.727555846458}, {"lowerIsBetter": false, "replicates": [524.0017766155476, 525.6399366433993, 533.2028617217261, 550.7824409358302, 550.7851937744283, 27147.647820241793, 34967.475487867705, 35431.2913741725, 35462.64537354626, 35517.2896542069, 38398.0, 38929.80535097328, 38952.0, 38956.0, 38984.22031559374, 7647.923520764804, 7808.453408261424, 7830.060392752849, 7830.216978302181, 7836.647350869196, 7658.693652253904, 7779.533228006309, 7784.260495252942, 7787.493812902171, 7944.126146123922, 7924.207579242058, 7992.520448773063, 7997.68009279631, 8003.759887203393, 8009.239122283374, 7874.960625196866, 7939.047314322261, 7950.4832185907735, 7954.284114429729, 7959.442839001273, 7854.646540905673, 7950.045994480642, 7968.521888686697, 7969.880451793228, 7975.60121993898, 37553.812230938944, 38003.809980950195, 38011.239775204616, 38044.61955380438, 38048.23903521914, 3064.892728754483, 3255.9023229303157, 3257.723093537052, 3320.369129865318, 3454.3954807908767, 28157.0, 28535.429291414264, 28717.13848584546, 28727.0, 28888.71111288902, 3420.281740834403, 3493.406120959443, 3494.912627184315, 3536.0629433200224, 3556.9466458002894, 244632.0, 246351.0, 246998.7650061756, 247369.0, 248683.0, 49306.260406093934, 53524.732376337866, 53751.46248537464, 53849.0, 56737.43262567404, 55933.40665933374, 56078.15882761762, 56094.0, 56136.15795763067, 56214.43785562174, 12155.817662735066, 12282.38588070593, 12287.324197169062, 12331.445084971198, 12343.629691109281, 8417.284530814826, 9357.438553686801, 9626.133647971716, 9717.368371055858, 9748.220142388593, 18164.90917545404, 18195.181216845274, 18262.178201980943, 18309.908450457664, 18326.725099123523, 6861.142357205349, 7094.361507464249, 7100.218975912646, 7160.713571457188, 7182.317679820409, 858.5707146426787, 899.0944692817652, 984.8522721591819, 996.5465713100522, 1045.310095337089, 27271.72728272692, 27881.302967425978, 27908.0, 28258.576121358197, 28336.0, 970.2529052629436, 1011.2769369900557, 1044.3942513342242, 1052.826283663187, 1070.6979993014925, 14161.85838141626, 14547.709045819025, 14560.0, 14703.338349774072, 14760.261986900612, 297042.0, 299245.0, 300609.0, 300881.0, 301955.0, 47566.0, 47935.04129917452, 47981.520184798406, 47982.0, 47991.28013079806, 1059.0944742245424, 1142.251825054574, 1208.987910120905, 1236.8021116621298, 1243.7947738623027, 24556.176039755657, 25082.37294067663, 25974.09090681817, 26005.869970650027, 27379.178624641292, 38280.80859595684, 38615.0, 38686.0, 38705.806470967465, 38725.80637096796, 198431.0, 201769.0, 202117.0, 202125.0, 202309.0, 26720.0, 30899.69100308968, 31010.844945775127, 31140.37719245648, 31358.529622056143, 37698.43452348272, 39007.609923900396, 39232.80383598064, 39483.40774888321, 39596.604033959295, 33136.834315828266, 33309.333813323115, 34131.82934085314, 34179.0, 34519.0, 33111.668883311824, 33155.83422082874, 33377.49933750947, 33418.49872251869, 33819.0, 32456.188595285308, 32926.17684557905, 32958.34083318368, 33001.83499082585, 33360.332793343514, 28913.7108628911, 30013.399732005673, 30123.246918826328, 30269.091927241338, 30300.090997270116, 23350.53298934046, 23983.400414989766, 24075.6663800517, 24303.0, 24335.26994190177], "unit": "score", "name": "ext.html", "value": 16789.7540594928}, {"lowerIsBetter": false, "replicates": [342.67103580562645, 347.08542989223395, 349.50021469298906, 350.2050345715227, 352.6315000824139, 14696.11823290602, 15230.847691523082, 15286.770698439532, 15658.373665053385, 15815.0, 14804.703905921875, 14892.106473611564, 15023.774643380359, 15743.448979285698, 15837.524874253762, 4911.066897289522, 5047.873803154932, 5049.823256186034, 5059.367579052619, 5069.0, 4855.5872750816225, 4888.902221955559, 4967.230079337708, 5007.674501157431, 5019.0, 4940.382452193476, 4953.925691114636, 4955.132851750947, 4962.429320628138, 4973.303737476756, 4853.951460485385, 4948.430930443009, 4950.55445009949, 5034.0, 5040.067587496325, 4860.270959356089, 4864.975675121602, 4869.269609558559, 4874.8537543873745, 4897.975510122426, 11204.21570490066, 11377.715557111056, 11602.76794464106, 11676.065914726802, 11680.766384672344, 1977.3079422202259, 2181.945451363713, 2388.581998150317, 2416.673749043874, 2475.7648023437746, 8798.956005219998, 8928.821423571557, 9014.48435110301, 9281.0, 9285.35002549815, 1749.912504374776, 1766.240516577871, 1769.7787776527935, 1878.305027139967, 1890.905454727272, 56168.0, 56716.0, 57512.0, 58205.70897145529, 58292.70853645747, 10168.593256269814, 10173.389596624227, 10252.897471025344, 10298.124659403884, 10435.0, 13056.673583160496, 13144.0799144059, 13175.736485270241, 13200.14199077057, 13213.801792973112, 6527.151470308924, 6626.271110177877, 6654.068430419745, 6785.626790526569, 6792.864142717217, 6103.816885493442, 6123.112148738497, 6177.444030037318, 6189.412005859436, 6233.875322493524, 4318.52496225415, 4399.84600538986, 4431.379606855043, 4495.527969563149, 4502.797374118172, 1741.8867773594675, 1770.0441761448674, 1785.7946336171506, 1792.9910350448165, 1793.704038833578, 835.5279267214005, 882.1795729971188, 890.8084761776249, 958.4297343080856, 1003.0621369019843, 15790.210489475481, 16031.198440078182, 16242.75635865463, 16279.430219942245, 16712.83287167137, 871.9346049046347, 900.5632268349846, 913.8126684029758, 925.6760133953197, 968.8546717992217, 9035.769286358625, 9412.811743765087, 9448.196903263162, 9538.475383853816, 9545.952270238604, 400418.0, 431619.0, 443315.0, 444655.0, 447205.0, 42085.57914420878, 46013.76993115013, 54624.45375546273, 67880.0, 69241.65379173071, 913.8172365526921, 924.6255266617031, 933.6638810028385, 953.7281874665687, 960.3373672166183, 14649.92675036618, 14802.555923322318, 14892.0, 14898.925505372405, 15467.0, 33006.50490242696, 33186.66813331836, 34157.65842341545, 34460.82769586136, 35263.294734105686, 40415.797921010206, 42914.78542607267, 42935.14129717451, 43185.56814431815, 43458.34812477752, 7094.0, 7433.8141546461775, 7476.289752473506, 7480.139783924918, 7520.473566850268, 6248.187735594343, 8755.693550725695, 10208.795824083625, 10921.726956826144, 11185.776284474428, 4833.903321933612, 5957.404259574181, 8652.0, 8875.911240887508, 9964.804223493227, 4452.30989196675, 7483.476156669199, 9711.223102151953, 9871.555779989774, 9995.050965062033, 9320.906790932275, 9513.619455221713, 9644.517774111408, 9953.502324883872, 10029.648962286285, 7234.095738032746, 7244.710211591478, 7300.050993370828, 7431.962840185981, 7455.962720186364, 8211.302039326723, 9745.658901938681, 9764.072413120743, 9783.315167938175, 10058.29591928558], "unit": "score", "name": "jquery.html", "value": 7595.859895871161}, {"lowerIsBetter": false, "replicates": [1253.636445430825, 1388.7361401333746, 1391.735570241654, 1513.2660659580108, 1714.7256438969766, 6983.511154219207, 7143.535670181441, 7160.892586611199, 7162.427005839533, 7189.82025449364, 7016.754413595525, 7219.133703955519, 7222.747203847854, 7225.638718064102, 7234.023406840075, 1912.5027492851889, 2195.6706494025943, 2207.9779202208015, 2239.32820153954, 2252.087904398721, 2253.188852013274, 2260.7174103237094, 2262.264763951714, 2264.1056782570877, 2264.932052038433, 2149.720536330283, 2210.5910406574753, 2211.756706762255, 2211.7677643847405, 2214.0922221889027, 2165.675148727688, 2180.3023032629567, 2191.5835991161707, 2257.7967982881455, 2261.423337049042, 1992.870463419873, 1995.5709522452742, 2000.9599808003904, 2001.6697244954564, 2013.6878783788536, 7330.303621156035, 7385.889211661829, 7405.074365704287, 7416.629168541552, 7417.554946703215, 4387.890302742425, 4519.638428925711, 4530.093981203772, 4544.045750392422, 4545.522720114406, 2932.472155012097, 2944.7055294470597, 2983.2690990707197, 3011.0, 3096.1640357103456, 911.9589618467185, 924.1128516624049, 927.5825878354767, 936.4474959773767, 962.1773383756857, 9935.453550054744, 9963.202943764481, 9976.451295178762, 10000.349977251455, 10005.249606279485, 4072.3077076897, 4185.121124563815, 4230.1539692061715, 4243.27864263076, 4259.787010649455, 8506.957465212634, 8589.48463092204, 8606.0, 8618.052014278424, 8623.741287761377, 3889.4554762333296, 4496.3705081288645, 4510.909781804346, 4512.458504979423, 4517.164324599959, 4013.8795836124964, 4108.301588729863, 4114.238865809834, 4118.5057793065025, 4127.318992366286, 3445.5348527948404, 3524.4360902255517, 3538.3454060998797, 3561.6972557332915, 3577.767445116059, 1167.731421772997, 1198.0894520164738, 1203.1157099531838, 1203.422357268516, 1213.5388552350228, 959.6065613098596, 992.0674565908023, 1161.3032180691687, 1180.3861991764406, 1189.4290740444635, 6734.292899245606, 6768.357006084512, 6776.322367763283, 6799.966000169968, 6812.0, 1114.331401159298, 1136.8635763708407, 1143.8273535588341, 1163.5462169753803, 1180.6930198148543, 5499.312585926759, 5532.640378375393, 5540.806071787468, 5586.581006424534, 5587.469190426903, 8497.702580409656, 9060.184583387396, 9070.27437804974, 9070.319726020574, 9081.45511269326, 8881.24509416694, 8884.067172946876, 8897.199252067345, 8905.243054340453, 8912.0, 6861.108055952794, 6906.240313565504, 6998.75504357345, 7044.894326585106, 7076.32774886385, 6740.090087838079, 6748.156480439945, 6756.932430675631, 6769.526133170631, 6773.221079575912, 7673.808154796175, 7991.160928102698, 8093.797655058671, 8163.306118979715, 8163.959180204061, 8129.75610731679, 8257.133001034805, 8295.04606970182, 8306.127856575215, 8429.662813487637, 6002.519798416029, 6044.486218671286, 6106.572539922163, 6133.938660613337, 6139.079138129317, 6862.897056544256, 6866.313368663294, 6875.243723190345, 6903.827404314932, 6939.132608423947, 6247.781327653511, 6408.231012278557, 6422.839429014312, 6449.4840412765925, 6514.315996820265, 6209.627422354673, 6224.813255602339, 6276.713273778956, 6321.715522801577, 6410.45511131559, 6488.870222595428, 6499.0901273820755, 6558.245801732862, 6559.6064236145985, 6562.80311590653, 6045.969770151121, 6053.364396738279, 6104.901117798839, 6109.20580324555, 6113.5414843886, 6129.295131059986, 6157.72290246931, 6160.537959653134, 6211.534134939807, 6215.409536094064], "unit": "score", "name": "mootools.html", "value": 4256.122948185297}, {"lowerIsBetter": false, "replicates": [301.1627675063325, 301.6787121715373, 302.7744330473797, 303.82226397557423, 306.5417201284081, 5180.740962951856, 5223.320968274119, 5232.2674825524455, 5289.8942021159555, 5293.364796224454, 5090.847274581768, 5127.564157046656, 5160.432352441228, 5160.870978225536, 5179.766910489027, 3885.630865067814, 4000.719949603529, 4100.507939047318, 4102.507699076115, 4111.033907031845, 4116.0, 4119.217348703752, 4119.423280740699, 4133.090720041586, 4142.647874930634, 4080.8163632636456, 4091.8772436826794, 4094.672426205911, 4097.446844675976, 4108.548059713429, 3906.9023274418223, 3984.6613037891816, 4083.4895638045246, 4100.282450571153, 4109.568495308009, 3612.9638703613155, 3614.34941710492, 3617.6744093031753, 3620.583632882226, 3632.763870348419, 5074.416442109131, 5075.365579302587, 5085.491450854922, 5086.491350864921, 5099.23511473282, 4722.527747225285, 4732.100900828831, 4733.834315798965, 4740.051989602093, 4742.478327383985, 5497.45025497451, 5516.586256030773, 5519.199716041192, 5523.530499907512, 5523.558115350762, 3962.6829853611644, 3967.0082479380153, 3968.6229808168177, 3969.0871099646956, 3969.106950936045, 5560.443955604448, 5747.540196784247, 5788.453080644503, 5807.419258074201, 5837.50381217597, 3886.281038007921, 3890.105275786528, 3907.492026036654, 3908.3746600543777, 3915.686745060388, 3936.1340505088833, 3970.7419017763755, 3973.0, 3973.8609148679657, 3974.066094467798, 4595.080983803253, 4595.563421474954, 4595.678302518859, 4596.2875754257475, 4607.9308810367875, 5546.195801608744, 5548.72256387179, 5556.222128901957, 5558.499735023867, 5558.916616250759, 1381.3576686840465, 1388.9236092015037, 1390.652336915771, 1391.0957877379583, 1391.6590435343405, 878.5607196401799, 912.4844462878452, 946.8721722567366, 959.836827739286, 966.0532677975623, 4816.373871396766, 4898.804047838046, 4918.754062296871, 4925.852224433273, 4929.260610908321, 5736.397678243808, 5813.5349172066135, 5818.6217895836635, 5822.534197264209, 5823.272090988627, 4931.3589233399425, 4959.628027897922, 4967.05625931072, 4967.776450059756, 4971.105201063843, 3025.9848700756356, 3090.876364945377, 3091.366269914662, 3094.164575564585, 3098.9535156972665, 5473.507384335429, 5475.06923822951, 5481.205225242397, 5481.369642491085, 5488.615796894179, 5667.263255776723, 5910.379410161957, 5929.644221346733, 5950.19672344228, 5952.345242023374, 5458.372287186945, 5461.781528738886, 5474.972625136928, 5481.835544933659, 5482.013237617267, 5778.797742079007, 5779.768809247583, 5789.2763404574425, 5790.449907258803, 5791.7683292667825, 5653.886922261449, 5656.830295091154, 5681.659100453986, 5683.658980461186, 5688.061469857427, 5469.808556700656, 5475.123980163155, 5477.780888764405, 5480.040992826319, 5480.808171713971, 3957.5053118360206, 4037.354023356249, 4121.835126594902, 4130.483689538808, 4134.875953721393, 5716.256886604715, 5736.225609542826, 5738.139279108, 5740.425957404394, 5742.253507044057, 5536.169574563848, 5537.667739935617, 5538.975289571442, 5544.085225937675, 5551.25058117149, 5512.972435137959, 5521.309836270466, 5527.50252477279, 5538.639988400902, 5543.196236545759, 5431.9185212221055, 5434.538064264581, 5436.0758671026815, 5438.320209973754, 5446.400895901527, 5346.8395948121615, 5562.443755624567, 5569.10894256917, 5574.860628484158, 5575.832725018256, 5409.756560954688, 5434.782608695607, 5437.8368648940595, 5439.755211015435, 5440.292761940922], "unit": "score", "name": "prototype.html", "value": 4165.9849068913945}, {"lowerIsBetter": false, "replicates": [670.3095811314346, 676.6718141701275, 701.5580184483774, 757.9014728085344, 771.1016665584594, 11758.470868810902, 11871.52513899444, 11876.228045177057, 11883.643490695282, 11883.821742673867, 12106.939465302683, 12145.939270303657, 12163.939180304085, 12168.209066410676, 12173.45219465124, 623.6912728199525, 763.0233301374222, 769.86142494351, 786.5909726941986, 787.9093904201033, 770.214381331042, 771.2210667226115, 772.5712229712507, 774.6862520679106, 776.4952780692566, 831.5343407691712, 831.767105210539, 832.2634468495395, 832.3216578488543, 832.4464231286188, 650.6453982579505, 786.7049856303886, 788.5938741548078, 789.6249281591256, 790.5612385126252, 585.4379795396425, 586.0359708279898, 586.3462239602854, 586.5014737473114, 587.3979171349358, 11425.371604561746, 11490.655280341603, 11497.827532587018, 11503.0, 11507.482163302671, 11557.19099663024, 11873.762524749456, 11961.88038119625, 12514.741519583178, 12701.618951431472, 9914.900850991542, 10053.0, 10081.89918100817, 10196.490175491195, 10246.18030557561, 3334.733221342287, 3335.282914173464, 3376.6285708572036, 3466.1507930556922, 3472.0451875734125, 44802.10395792066, 45016.0, 45191.322130168075, 45293.77353113213, 45638.77180614076, 9603.37578057424, 9749.31754777173, 9792.510374481248, 9794.559244834, 9800.313978021613, 17036.06301653396, 17045.31818727262, 17053.829461705223, 17065.82934170667, 17068.658626827393, 6673.432758215509, 6824.829379265558, 6834.316568343126, 6906.585604863724, 6930.099087118642, 3679.5952445231005, 3766.1714422826935, 3800.3539398302355, 3841.673457756122, 3843.2505661395758, 2812.8452935088358, 2884.048264072851, 2909.738123568889, 2927.5315949447986, 2941.2205765472168, 473.56195519144654, 569.6268943841791, 582.0309185206668, 585.7042193692158, 589.5107061139244, 560.9158626206101, 564.8672561947939, 578.4620303118056, 581.1805354450289, 587.4184557288254, 7212.531185472927, 7380.557166570023, 7518.323350898446, 7607.9239207608325, 7652.69389224436, 525.9289995850588, 543.6330476928058, 552.0835413214046, 565.3893794701712, 568.1534513574826, 3587.712982961357, 3677.9632203678157, 3740.36413809653, 3847.6921846252235, 3854.1713531590844, 48865.0, 49018.26472602914, 49102.26346604804, 49841.25238121431, 50069.0, 44507.55492445034, 44573.0, 45164.77417612891, 45543.08913821705, 45915.081698365844, 40787.59212407838, 41164.58835411668, 41436.792816035726, 41533.584664153575, 41635.37546936798, 8037.7588672339925, 8234.135415781257, 8240.258376746122, 8713.825723485621, 8717.738467845975, 30593.694063059083, 31324.843375782973, 32589.511157333134, 33537.66462335443, 34170.31659366848, 38969.2206155881, 39275.803620981715, 39765.0, 39933.60066399415, 40054.79972600235, 10537.57849686004, 10618.681439556825, 10654.264245273043, 10933.070688991525, 10988.560457581607, 11113.666590002313, 11508.654740357802, 11733.237339572901, 12035.939820301193, 12181.75636487283, 10372.325798823053, 10569.524371403151, 10571.577136914437, 10674.679759607225, 10688.412137332522, 11013.174011948975, 11227.71930701739, 11718.121140914294, 11803.82294265604, 11838.408079596158, 10690.893091069302, 10781.0, 11144.721381965515, 11256.549738010388, 11263.774724505627, 9222.40054396462, 9497.335186536877, 9531.809363812823, 9755.853662194932, 9959.350602296125, 9609.711708648752, 9644.373115747454, 9671.854922176313, 9674.85487717699, 9693.660721874701], "unit": "score", "name": "yui.html", "value": 5867.804516528723}], "name": "dromaeo_css", "value": 6260.404338911284}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 111.0, 113.0, 112.0, 102.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 156.0, 173.0, 137.0, 153.0, 163.0, 133.0, 172.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 97.0, 96.0, 73.0, 72.0, 73.0, 118.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 142.0, 94.0, 94.0, 95.0, 139.0, 93.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 69.0, 69.0, 69.0, 79.0, 67.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0, 80.0, 82.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [124.0, 117.0, 123.0, 121.0, 121.0, 118.0, 120.0, 123.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 146.0, 141.0, 142.0, 134.0, 147.0, 151.0, 139.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1516.6000000000001}]} 12:37:51 INFO - Return code: 0 12:37:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:37:51 ERROR - # TBPL SUCCESS # 12:37:51 INFO - Running post-action listener: _resource_record_post_action 12:37:51 INFO - Running post-run listener: _resource_record_post_run 12:37:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283648000; Read time: 16; Write time: 170740 12:37:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5656576; Read time: 0; Write time: 464 12:37:52 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276451328; Read time: 16; Write time: 169872 12:37:52 INFO - Running post-run listener: _upload_blobber_files 12:37:52 INFO - Blob upload gear active. 12:37:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:52 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 12:37:52 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'] 12:37:52 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 12:37:52 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:54 INFO - (blobuploader) - INFO - Done attempting. 12:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:54 INFO - (blobuploader) - INFO - Done attempting. 12:37:54 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:54 INFO - Return code: 0 12:37:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1537f323af6f6698ff21e2537a548e85842a6c1d86c585c7df97d5972fb9497c444403774eb55c92676f4c4a6975edd14aca5289bc61c355568279c256443394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdd326d499eda45fd00287516ba4f9e468ad7d061768b809fdf57cd811fc991ebf6127ef01fe0afce5249982eedee20c4ff5966ebab0aa3aab12092ea53da5a5"} 12:37:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:54 INFO - Contents: 12:37:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1537f323af6f6698ff21e2537a548e85842a6c1d86c585c7df97d5972fb9497c444403774eb55c92676f4c4a6975edd14aca5289bc61c355568279c256443394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdd326d499eda45fd00287516ba4f9e468ad7d061768b809fdf57cd811fc991ebf6127ef01fe0afce5249982eedee20c4ff5966ebab0aa3aab12092ea53da5a5"} 12:37:54 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:54 INFO - Copying logs to upload dir... 12:37:54 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.272731 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-03-21 12:37:54.803550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 12:37:54.807538) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 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/1537f323af6f6698ff21e2537a548e85842a6c1d86c585c7df97d5972fb9497c444403774eb55c92676f4c4a6975edd14aca5289bc61c355568279c256443394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdd326d499eda45fd00287516ba4f9e468ad7d061768b809fdf57cd811fc991ebf6127ef01fe0afce5249982eedee20c4ff5966ebab0aa3aab12092ea53da5a5"} build_url:https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/V_c_oKHTRpKfgVS-Vb5znw/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/1537f323af6f6698ff21e2537a548e85842a6c1d86c585c7df97d5972fb9497c444403774eb55c92676f4c4a6975edd14aca5289bc61c355568279c256443394", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdd326d499eda45fd00287516ba4f9e468ad7d061768b809fdf57cd811fc991ebf6127ef01fe0afce5249982eedee20c4ff5966ebab0aa3aab12092ea53da5a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 12:37:54.835786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:37:54.836176) ========= 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=1f5564757af27664ca02d71f000001b0-1458587701.789851-1089978115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 12:37:54.922233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 12:37:54.922589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 12:37:54.922894) ========= ========= Total master_lag: 7.53 =========