builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1450196433.65 results: success (0) buildid: 20151215070825 builduid: 1539578ed650459e8fe5bf194deeb4de revision: 0fb60a06349bce8b13f7f7d3c31305af13320b77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.646005) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.646628) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.646954) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.687013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.687290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.707211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.707512) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.757747) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.758030) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.758365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:33.758648) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 08:20:33-- 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% 224M=0s 2015-12-15 08:20:34 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.425050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.196372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.196682) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017236 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.252506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.252849) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0fb60a06349bce8b13f7f7d3c31305af13320b77 --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 0fb60a06349bce8b13f7f7d3c31305af13320b77 --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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 08:20:34,354 truncating revision to first 12 chars 2015-12-15 08:20:34,354 Setting DEBUG logging. 2015-12-15 08:20:34,354 attempt 1/10 2015-12-15 08:20:34,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0fb60a06349b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 08:20:34,596 unpacking tar archive at: fx-team-0fb60a06349b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.785213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.785502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.794592) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.794840) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 08:20:34.795221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-15 08:20:34.795792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:34 INFO - MultiFileLogger online at 20151215 08:20:34 in /builds/slave/test 08:20:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:20:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:34 INFO - {'append_to_log': False, 08:20:34 INFO - 'base_work_dir': '/builds/slave/test', 08:20:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:20:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:34 INFO - 'branch': 'Fx-Team-Non-PGO', 08:20:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:34 INFO - 'config_files': ('talos/linux_config.py',), 08:20:34 INFO - 'default_actions': ('clobber', 08:20:34 INFO - 'read-buildbot-config', 08:20:34 INFO - 'download-and-extract', 08:20:34 INFO - 'populate-webroot', 08:20:34 INFO - 'create-virtualenv', 08:20:34 INFO - 'install', 08:20:34 INFO - 'run-tests'), 08:20:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:34 INFO - 'download_minidump_stackwalk': True, 08:20:34 INFO - 'download_symbols': 'ondemand', 08:20:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:34 INFO - 'installer_path': 'installer.exe', 08:20:34 INFO - 'log_level': 'info', 08:20:34 INFO - 'log_name': 'talos', 08:20:34 INFO - 'log_to_console': True, 08:20:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:34 INFO - 'opt_config_files': (), 08:20:34 INFO - 'pip_index': False, 08:20:34 INFO - 'sps_profile': False, 08:20:34 INFO - 'sps_profile_interval': 0, 08:20:34 INFO - 'suite': 'dromaeojs', 08:20:34 INFO - 'system_bits': '64', 08:20:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:34 INFO - 'title': 'talos-linux64-ix-019', 08:20:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:34 INFO - 'use_talos_json': True, 08:20:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:34 INFO - 'work_dir': 'build'} 08:20:34 INFO - ##### 08:20:34 INFO - ##### Running clobber step. 08:20:34 INFO - ##### 08:20:34 INFO - Running pre-action listener: _resource_record_pre_action 08:20:34 INFO - Running main action method: clobber 08:20:34 INFO - rmtree: /builds/slave/test/build 08:20:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running read-buildbot-config step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: read_buildbot_config 08:20:35 INFO - Using buildbot properties: 08:20:35 INFO - { 08:20:35 INFO - "properties": { 08:20:35 INFO - "buildnumber": 1012, 08:20:35 INFO - "product": "firefox", 08:20:35 INFO - "script_repo_revision": "production", 08:20:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:20:35 INFO - "repository": "", 08:20:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:20:35 INFO - "buildid": "20151215070825", 08:20:35 INFO - "slavename": "talos-linux64-ix-019", 08:20:35 INFO - "pgo_build": "False", 08:20:35 INFO - "basedir": "/builds/slave/test", 08:20:35 INFO - "project": "", 08:20:35 INFO - "platform": "ubuntu64_hw", 08:20:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:20:35 INFO - "slavebuilddir": "test", 08:20:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:20:35 INFO - "branch": "fx-team", 08:20:35 INFO - "repo_path": "integration/fx-team", 08:20:35 INFO - "stage_platform": "linux64", 08:20:35 INFO - "builduid": "1539578ed650459e8fe5bf194deeb4de", 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - }, 08:20:35 INFO - "sourcestamp": { 08:20:35 INFO - "repository": "", 08:20:35 INFO - "hasPatch": false, 08:20:35 INFO - "project": "", 08:20:35 INFO - "branch": "fx-team-linux64-talos", 08:20:35 INFO - "changes": [ 08:20:35 INFO - { 08:20:35 INFO - "category": null, 08:20:35 INFO - "files": [ 08:20:35 INFO - { 08:20:35 INFO - "url": null, 08:20:35 INFO - "name": "https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 08:20:35 INFO - } 08:20:35 INFO - ], 08:20:35 INFO - "repository": "", 08:20:35 INFO - "rev": "0fb60a06349bce8b13f7f7d3c31305af13320b77", 08:20:35 INFO - "who": "gijskruitbosch@gmail.com", 08:20:35 INFO - "when": 1450196404, 08:20:35 INFO - "number": 7362340, 08:20:35 INFO - "comments": "Bug 1230831 - fix treatment of tabs with no group information, r=mconley", 08:20:35 INFO - "project": "", 08:20:35 INFO - "at": "Tue 15 Dec 2015 08:20:04", 08:20:35 INFO - "branch": "fx-team-linux64-talos", 08:20:35 INFO - "revlink": "", 08:20:35 INFO - "properties": [ 08:20:35 INFO - [ 08:20:35 INFO - "buildid", 08:20:35 INFO - "20151215070825", 08:20:35 INFO - "Change" 08:20:35 INFO - ], 08:20:35 INFO - [ 08:20:35 INFO - "builduid", 08:20:35 INFO - "1539578ed650459e8fe5bf194deeb4de", 08:20:35 INFO - "Change" 08:20:35 INFO - ], 08:20:35 INFO - [ 08:20:35 INFO - "pgo_build", 08:20:35 INFO - "False", 08:20:35 INFO - "Change" 08:20:35 INFO - ] 08:20:35 INFO - ], 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - } 08:20:35 INFO - ], 08:20:35 INFO - "revision": "0fb60a06349bce8b13f7f7d3c31305af13320b77" 08:20:35 INFO - } 08:20:35 INFO - } 08:20:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running download-and-extract step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: download_and_extract 08:20:35 INFO - mkdir: /builds/slave/test/build/tests 08:20:35 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')]} 08:20:35 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json 08:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json 08:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:20:44 INFO - Downloaded 1302 bytes. 08:20:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:20:44 INFO - Using the following test package requirements: 08:20:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:20:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'jsshell-linux-x86_64.zip'], 08:20:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:20:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:20:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:20:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:20:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:20:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:20:44 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')]} 08:20:44 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:20:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:48 INFO - Downloaded 21863279 bytes. 08:20:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:20:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:20:49 INFO - Return code: 0 08:20:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:49 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:50 INFO - Downloaded 21863279 bytes. 08:20:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:20:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:20:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:20:51 INFO - Return code: 0 08:20:51 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')]} 08:20:51 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:20:53 INFO - Downloaded 11132052 bytes. 08:20:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:20:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:20:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:20:54 INFO - Return code: 0 08:20:54 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')]} 08:20:54 INFO - https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:20:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:20:55 INFO - Downloaded 57739652 bytes. 08:20:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:55 INFO - mkdir: /builds/slave/test/properties 08:20:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:55 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:55 INFO - Contents: 08:20:55 INFO - build_url:https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:20:55 INFO - Running post-action listener: _resource_record_post_action 08:20:55 INFO - Running post-action listener: set_extra_try_arguments 08:20:55 INFO - ##### 08:20:55 INFO - ##### Running populate-webroot step. 08:20:55 INFO - ##### 08:20:55 INFO - Running pre-action listener: _resource_record_pre_action 08:20:55 INFO - Running main action method: populate_webroot 08:20:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:55 INFO - '--tppagecycles', 08:20:55 INFO - '7'], 08:20:55 INFO - 'tests': ['tsvgm']}}, 08:20:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:20:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:20:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:20:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'tests': ['damp', 'tps']}, 08:20:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['damp', 'tps']}, 08:20:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:20:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:55 INFO - 'other': {'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'other_l64': {'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'other_nol64': {'tests': ['a11yr', 08:20:55 INFO - 'ts_paint', 08:20:55 INFO - 'tpaint', 08:20:55 INFO - 'sessionrestore', 08:20:55 INFO - 'sessionrestore_no_auto_restore']}, 08:20:55 INFO - 'svgr': {'tests': ['tsvgx', 08:20:55 INFO - 'tsvgr_opacity', 08:20:55 INFO - 'tart', 08:20:55 INFO - 'tscrollx', 08:20:55 INFO - 'cart']}, 08:20:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['tsvgx', 08:20:55 INFO - 'tsvgr_opacity', 08:20:55 INFO - 'tart', 08:20:55 INFO - 'tscrollx', 08:20:55 INFO - 'cart']}, 08:20:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'tests': ['tp5o']}, 08:20:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'talos_options': ['--e10s'], 08:20:55 INFO - 'tests': ['tp5o']}, 08:20:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'talos_options': ['--xperf_path', 08:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:55 INFO - 'tests': ['tp5n']}, 08:20:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:55 INFO - 'talos_options': ['--e10s', 08:20:55 INFO - '--xperf_path', 08:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:55 INFO - 'tests': ['tp5n']}}, 08:20:55 INFO - 'talos.zip': {'path': '', 08:20:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:55 INFO - Running post-action listener: _resource_record_post_action 08:20:55 INFO - ##### 08:20:55 INFO - ##### Running create-virtualenv step. 08:20:55 INFO - ##### 08:20:55 INFO - Running pre-action listener: _resource_record_pre_action 08:20:55 INFO - Running main action method: create_virtualenv 08:20:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:55 INFO - Using real prefix '/usr' 08:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:58 INFO - Installing pip.................done. 08:20:58 INFO - Return code: 0 08:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:20:58 INFO - Using env: {'DISPLAY': ':0', 08:20:58 INFO - 'HOME': '/home/cltbld', 08:20:58 INFO - 'LANG': 'en_US.UTF-8', 08:20:58 INFO - 'LANGUAGE': 'en_US:en', 08:20:58 INFO - 'LOGNAME': 'cltbld', 08:20:58 INFO - 'MAIL': '/var/mail/cltbld', 08:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:58 INFO - 'MOZ_NO_REMOTE': '1', 08:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:58 INFO - 'NO_EM_RESTART': '1', 08:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:58 INFO - 'PWD': '/builds/slave/test', 08:20:58 INFO - 'SHELL': '/bin/bash', 08:20:58 INFO - 'SHLVL': '1', 08:20:58 INFO - 'TERM': 'linux', 08:20:58 INFO - 'TMOUT': '86400', 08:20:58 INFO - 'USER': 'cltbld', 08:20:58 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:58 INFO - '_': '/tools/buildbot/bin/python'} 08:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:20:58 INFO - Cleaning up... 08:20:58 INFO - Return code: 0 08:20:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:20:58 INFO - Using env: {'DISPLAY': ':0', 08:20:58 INFO - 'HOME': '/home/cltbld', 08:20:58 INFO - 'LANG': 'en_US.UTF-8', 08:20:58 INFO - 'LANGUAGE': 'en_US:en', 08:20:58 INFO - 'LOGNAME': 'cltbld', 08:20:58 INFO - 'MAIL': '/var/mail/cltbld', 08:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:58 INFO - 'MOZ_NO_REMOTE': '1', 08:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:58 INFO - 'NO_EM_RESTART': '1', 08:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:58 INFO - 'PWD': '/builds/slave/test', 08:20:58 INFO - 'SHELL': '/bin/bash', 08:20:58 INFO - 'SHLVL': '1', 08:20:58 INFO - 'TERM': 'linux', 08:20:58 INFO - 'TMOUT': '86400', 08:20:58 INFO - 'USER': 'cltbld', 08:20:58 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:58 INFO - '_': '/tools/buildbot/bin/python'} 08:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:58 INFO - Downloading/unpacking psutil>=0.7.1 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:00 INFO - Installing collected packages: psutil 08:21:00 INFO - Running setup.py install for psutil 08:21:00 INFO - building 'psutil._psutil_linux' extension 08:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:21:00 INFO - building 'psutil._psutil_posix' extension 08:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:00 INFO - Successfully installed psutil 08:21:00 INFO - Cleaning up... 08:21:00 INFO - Return code: 0 08:21:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:21:00 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')]} 08:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:00 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')]} 08:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:00 INFO - Using env: {'DISPLAY': ':0', 08:21:00 INFO - 'HOME': '/home/cltbld', 08:21:00 INFO - 'LANG': 'en_US.UTF-8', 08:21:00 INFO - 'LANGUAGE': 'en_US:en', 08:21:00 INFO - 'LOGNAME': 'cltbld', 08:21:00 INFO - 'MAIL': '/var/mail/cltbld', 08:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:00 INFO - 'MOZ_NO_REMOTE': '1', 08:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:00 INFO - 'NO_EM_RESTART': '1', 08:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:00 INFO - 'PWD': '/builds/slave/test', 08:21:00 INFO - 'SHELL': '/bin/bash', 08:21:00 INFO - 'SHLVL': '1', 08:21:00 INFO - 'TERM': 'linux', 08:21:00 INFO - 'TMOUT': '86400', 08:21:00 INFO - 'USER': 'cltbld', 08:21:00 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:00 INFO - '_': '/tools/buildbot/bin/python'} 08:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:21:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:21:02 INFO - Installing collected packages: mozsystemmonitor 08:21:02 INFO - Running setup.py install for mozsystemmonitor 08:21:02 INFO - Successfully installed mozsystemmonitor 08:21:02 INFO - Cleaning up... 08:21:03 INFO - Return code: 0 08:21:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:03 INFO - Using env: {'DISPLAY': ':0', 08:21:03 INFO - 'HOME': '/home/cltbld', 08:21:03 INFO - 'LANG': 'en_US.UTF-8', 08:21:03 INFO - 'LANGUAGE': 'en_US:en', 08:21:03 INFO - 'LOGNAME': 'cltbld', 08:21:03 INFO - 'MAIL': '/var/mail/cltbld', 08:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:03 INFO - 'MOZ_NO_REMOTE': '1', 08:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:03 INFO - 'NO_EM_RESTART': '1', 08:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:03 INFO - 'PWD': '/builds/slave/test', 08:21:03 INFO - 'SHELL': '/bin/bash', 08:21:03 INFO - 'SHLVL': '1', 08:21:03 INFO - 'TERM': 'linux', 08:21:03 INFO - 'TMOUT': '86400', 08:21:03 INFO - 'USER': 'cltbld', 08:21:03 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:03 INFO - '_': '/tools/buildbot/bin/python'} 08:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:04 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 08:21:04 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 08:21:04 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 08:21:04 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 08:21:04 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 08:21:04 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 08:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:05 INFO - Downloading docopt-0.6.1.tar.gz 08:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:05 INFO - Running setup.py install for blobuploader 08:21:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:05 INFO - Running setup.py install for requests 08:21:06 INFO - Running setup.py install for docopt 08:21:06 INFO - Successfully installed blobuploader requests docopt 08:21:06 INFO - Cleaning up... 08:21:06 INFO - Return code: 0 08:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 08:21:06 INFO - Using env: {'DISPLAY': ':0', 08:21:06 INFO - 'HOME': '/home/cltbld', 08:21:06 INFO - 'LANG': 'en_US.UTF-8', 08:21:06 INFO - 'LANGUAGE': 'en_US:en', 08:21:06 INFO - 'LOGNAME': 'cltbld', 08:21:06 INFO - 'MAIL': '/var/mail/cltbld', 08:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:06 INFO - 'MOZ_NO_REMOTE': '1', 08:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:06 INFO - 'NO_EM_RESTART': '1', 08:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:06 INFO - 'PWD': '/builds/slave/test', 08:21:06 INFO - 'SHELL': '/bin/bash', 08:21:06 INFO - 'SHLVL': '1', 08:21:06 INFO - 'TERM': 'linux', 08:21:06 INFO - 'TMOUT': '86400', 08:21:06 INFO - 'USER': 'cltbld', 08:21:06 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:06 INFO - '_': '/tools/buildbot/bin/python'} 08:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:06 INFO - Running setup.py (path:/tmp/pip-AjdbPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:06 INFO - Running setup.py (path:/tmp/pip-lk6Ebx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:06 INFO - Running setup.py (path:/tmp/pip-IaarBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:06 INFO - Running setup.py (path:/tmp/pip-wIG4_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:06 INFO - Running setup.py (path:/tmp/pip-is3vcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:06 INFO - Running setup.py (path:/tmp/pip-HZE81s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:06 INFO - Running setup.py (path:/tmp/pip-IWWWGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:06 INFO - Running setup.py (path:/tmp/pip-EdHZue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:07 INFO - Running setup.py (path:/tmp/pip-JV7sna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:07 INFO - Running setup.py (path:/tmp/pip-DKMrz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:07 INFO - Running setup.py (path:/tmp/pip-_7bDwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:07 INFO - Running setup.py (path:/tmp/pip-PgGP0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:07 INFO - Running setup.py (path:/tmp/pip-V5TH_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:07 INFO - Running setup.py (path:/tmp/pip-H7gLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:07 INFO - Running setup.py (path:/tmp/pip-dTqzhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:07 INFO - Running setup.py (path:/tmp/pip-luyC__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:07 INFO - Running setup.py (path:/tmp/pip-n8Nl7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:07 INFO - Running setup.py install for manifestparser 08:21:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Running setup.py install for mozcrash 08:21:07 INFO - Running setup.py install for mozdebug 08:21:07 INFO - Running setup.py install for mozdevice 08:21:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozfile 08:21:08 INFO - Running setup.py install for mozhttpd 08:21:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozinfo 08:21:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozInstall 08:21:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozleak 08:21:08 INFO - Running setup.py install for mozlog 08:21:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for moznetwork 08:21:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozprocess 08:21:08 INFO - Running setup.py install for mozprofile 08:21:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:08 INFO - Running setup.py install for mozrunner 08:21:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:09 INFO - Running setup.py install for mozscreenshot 08:21:09 INFO - Running setup.py install for moztest 08:21:09 INFO - Running setup.py install for mozversion 08:21:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:09 INFO - Cleaning up... 08:21:09 INFO - Return code: 0 08:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:09 INFO - Using env: {'DISPLAY': ':0', 08:21:09 INFO - 'HOME': '/home/cltbld', 08:21:09 INFO - 'LANG': 'en_US.UTF-8', 08:21:09 INFO - 'LANGUAGE': 'en_US:en', 08:21:09 INFO - 'LOGNAME': 'cltbld', 08:21:09 INFO - 'MAIL': '/var/mail/cltbld', 08:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:09 INFO - 'MOZ_NO_REMOTE': '1', 08:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:09 INFO - 'NO_EM_RESTART': '1', 08:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:09 INFO - 'PWD': '/builds/slave/test', 08:21:09 INFO - 'SHELL': '/bin/bash', 08:21:09 INFO - 'SHLVL': '1', 08:21:09 INFO - 'TERM': 'linux', 08:21:09 INFO - 'TMOUT': '86400', 08:21:09 INFO - 'USER': 'cltbld', 08:21:09 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:09 INFO - '_': '/tools/buildbot/bin/python'} 08:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:09 INFO - Running setup.py (path:/tmp/pip-qazYyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:09 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)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:09 INFO - Running setup.py (path:/tmp/pip-8Ci6Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:09 INFO - Running setup.py (path:/tmp/pip-6u1uI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:09 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)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:09 INFO - Running setup.py (path:/tmp/pip-VObIIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:09 INFO - Running setup.py (path:/tmp/pip-LrPPUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:10 INFO - Running setup.py (path:/tmp/pip-GCqR57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:10 INFO - Running setup.py (path:/tmp/pip-UycNP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:10 INFO - Running setup.py (path:/tmp/pip-M0kYsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:10 INFO - Running setup.py (path:/tmp/pip-XYceqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:10 INFO - Running setup.py (path:/tmp/pip-0i4Nmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:10 INFO - Running setup.py (path:/tmp/pip-Qx5Yqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:10 INFO - Running setup.py (path:/tmp/pip-35tClW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:10 INFO - Running setup.py (path:/tmp/pip-f5ujIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:10 INFO - Running setup.py (path:/tmp/pip-28aRfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:10 INFO - Running setup.py (path:/tmp/pip-zZtv0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:10 INFO - Running setup.py (path:/tmp/pip-zqIN4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:10 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)) 08:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:10 INFO - Running setup.py (path:/tmp/pip-wquxJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:10 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)) 08:21:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:10 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)) 08:21:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:10 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 08:21:10 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 08:21:10 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 08:21:10 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 08:21:10 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 08:21:10 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 08:21:12 INFO - Downloading blessings-1.5.1.tar.gz 08:21:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:12 INFO - Installing collected packages: blessings 08:21:12 INFO - Running setup.py install for blessings 08:21:12 INFO - Successfully installed blessings 08:21:12 INFO - Cleaning up... 08:21:12 INFO - Return code: 0 08:21:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:12 INFO - Reading from file tmpfile_stdout 08:21:12 INFO - Current package versions: 08:21:12 INFO - argparse == 1.2.1 08:21:12 INFO - blessings == 1.5.1 08:21:12 INFO - blobuploader == 1.2.4 08:21:12 INFO - docopt == 0.6.1 08:21:12 INFO - manifestparser == 1.1 08:21:12 INFO - mozInstall == 1.12 08:21:12 INFO - mozcrash == 0.16 08:21:12 INFO - mozdebug == 0.1 08:21:12 INFO - mozdevice == 0.47 08:21:12 INFO - mozfile == 1.2 08:21:12 INFO - mozhttpd == 0.7 08:21:12 INFO - mozinfo == 0.9 08:21:12 INFO - mozleak == 0.1 08:21:12 INFO - mozlog == 3.1 08:21:12 INFO - moznetwork == 0.27 08:21:12 INFO - mozprocess == 0.22 08:21:12 INFO - mozprofile == 0.27 08:21:12 INFO - mozrunner == 6.11 08:21:12 INFO - mozscreenshot == 0.1 08:21:12 INFO - mozsystemmonitor == 0.0 08:21:12 INFO - moztest == 0.7 08:21:12 INFO - mozversion == 1.4 08:21:12 INFO - psutil == 3.1.1 08:21:12 INFO - requests == 1.2.3 08:21:12 INFO - wsgiref == 0.1.2 08:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:12 INFO - Using env: {'DISPLAY': ':0', 08:21:12 INFO - 'HOME': '/home/cltbld', 08:21:12 INFO - 'LANG': 'en_US.UTF-8', 08:21:12 INFO - 'LANGUAGE': 'en_US:en', 08:21:12 INFO - 'LOGNAME': 'cltbld', 08:21:12 INFO - 'MAIL': '/var/mail/cltbld', 08:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:13 INFO - 'MOZ_NO_REMOTE': '1', 08:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:13 INFO - 'NO_EM_RESTART': '1', 08:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:13 INFO - 'PWD': '/builds/slave/test', 08:21:13 INFO - 'SHELL': '/bin/bash', 08:21:13 INFO - 'SHLVL': '1', 08:21:13 INFO - 'TERM': 'linux', 08:21:13 INFO - 'TMOUT': '86400', 08:21:13 INFO - 'USER': 'cltbld', 08:21:13 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:13 INFO - '_': '/tools/buildbot/bin/python'} 08:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:13 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 1)) 08:21:13 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 2)) 08:21:13 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 3)) 08:21:13 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 4)) 08:21:13 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 5)) 08:21:13 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 6)) 08:21:13 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 7)) 08:21:13 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 8)) 08:21:13 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:13 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 3)) 08:21:13 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:13 INFO - Cleaning up... 08:21:13 INFO - Return code: 0 08:21:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:13 INFO - Using env: {'DISPLAY': ':0', 08:21:13 INFO - 'HOME': '/home/cltbld', 08:21:13 INFO - 'LANG': 'en_US.UTF-8', 08:21:13 INFO - 'LANGUAGE': 'en_US:en', 08:21:13 INFO - 'LOGNAME': 'cltbld', 08:21:13 INFO - 'MAIL': '/var/mail/cltbld', 08:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:13 INFO - 'MOZ_NO_REMOTE': '1', 08:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:13 INFO - 'NO_EM_RESTART': '1', 08:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:13 INFO - 'PWD': '/builds/slave/test', 08:21:13 INFO - 'SHELL': '/bin/bash', 08:21:13 INFO - 'SHLVL': '1', 08:21:13 INFO - 'TERM': 'linux', 08:21:13 INFO - 'TMOUT': '86400', 08:21:13 INFO - 'USER': 'cltbld', 08:21:13 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:13 INFO - '_': '/tools/buildbot/bin/python'} 08:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:13 INFO - Downloading/unpacking jsonschema 08:21:13 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 08:21:13 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 08:21:13 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 08:21:13 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 08:21:13 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 08:21:13 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 08:21:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:21:15 INFO - Downloading/unpacking functools32 (from jsonschema) 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:15 INFO - warning: no files found matching '*.txt' 08:21:15 INFO - no previously-included directories found matching 'build' 08:21:15 INFO - no previously-included directories found matching 'dist' 08:21:15 INFO - no previously-included directories found matching '.git*' 08:21:15 INFO - Installing collected packages: jsonschema, functools32 08:21:15 INFO - Running setup.py install for functools32 08:21:15 INFO - warning: no files found matching '*.txt' 08:21:15 INFO - no previously-included directories found matching 'build' 08:21:15 INFO - no previously-included directories found matching 'dist' 08:21:15 INFO - no previously-included directories found matching '.git*' 08:21:15 INFO - Successfully installed jsonschema functools32 08:21:15 INFO - Cleaning up... 08:21:15 INFO - Return code: 0 08:21:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5600a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e24240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', '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 08:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:21:15 INFO - Using env: {'DISPLAY': ':0', 08:21:15 INFO - 'HOME': '/home/cltbld', 08:21:15 INFO - 'LANG': 'en_US.UTF-8', 08:21:15 INFO - 'LANGUAGE': 'en_US:en', 08:21:15 INFO - 'LOGNAME': 'cltbld', 08:21:15 INFO - 'MAIL': '/var/mail/cltbld', 08:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:15 INFO - 'MOZ_NO_REMOTE': '1', 08:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:15 INFO - 'NO_EM_RESTART': '1', 08:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:15 INFO - 'PWD': '/builds/slave/test', 08:21:15 INFO - 'SHELL': '/bin/bash', 08:21:15 INFO - 'SHLVL': '1', 08:21:15 INFO - 'TERM': 'linux', 08:21:15 INFO - 'TMOUT': '86400', 08:21:15 INFO - 'USER': 'cltbld', 08:21:15 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:15 INFO - '_': '/tools/buildbot/bin/python'} 08:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:15 INFO - Downloading/unpacking flake8 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:15 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 08:21:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:21:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:21:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:21:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 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 08:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:18 INFO - no previously-included directories found matching 'docs/_build' 08:21:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:18 INFO - Running setup.py install for pep8 08:21:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:18 INFO - no previously-included directories found matching 'docs/_build' 08:21:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:21:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:21:18 INFO - Cleaning up... 08:21:18 INFO - Return code: 0 08:21:18 INFO - Running post-action listener: _resource_record_post_action 08:21:18 INFO - Running post-action listener: _start_resource_monitoring 08:21:18 INFO - Starting resource monitoring. 08:21:18 INFO - ##### 08:21:18 INFO - ##### Running install step. 08:21:18 INFO - ##### 08:21:18 INFO - Running pre-action listener: _resource_record_pre_action 08:21:18 INFO - Running main action method: install 08:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:18 INFO - Reading from file tmpfile_stdout 08:21:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:18 INFO - Reading from file tmpfile_stdout 08:21:18 INFO - Output received: 08:21:18 INFO - Usage: mozinstall [options] installer 08:21:18 INFO - Options: 08:21:18 INFO - -h, --help show this help message and exit 08:21:18 INFO - -d DEST, --destination=DEST 08:21:18 INFO - Directory to install application into. [default: 08:21:18 INFO - "/builds/slave/test"] 08:21:18 INFO - --app=APP Application being installed. [default: firefox] 08:21:18 INFO - mkdir: /builds/slave/test/build/application 08:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:21:33 INFO - Reading from file tmpfile_stdout 08:21:33 INFO - Output received: 08:21:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:33 INFO - Running post-action listener: _resource_record_post_action 08:21:33 INFO - ##### 08:21:33 INFO - ##### Running run-tests step. 08:21:33 INFO - ##### 08:21:33 INFO - Running pre-action listener: _resource_record_pre_action 08:21:33 INFO - Running main action method: run_tests 08:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:33 INFO - Python 2.7.3 08:21:33 INFO - Return code: 0 08:21:33 INFO - grabbing minidump binary from tooltool 08:21: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')]} 08:21:33 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 0x1eb30b0>, '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 0x1eb3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:33 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 08:21:33 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 08:21:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:33 INFO - Return code: 0 08:21:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:21:34 INFO - Return code: 0 08:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 08:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 08:21:34 INFO - Using env: {'DISPLAY': ':0', 08:21:34 INFO - 'HOME': '/home/cltbld', 08:21:34 INFO - 'LANG': 'en_US.UTF-8', 08:21:34 INFO - 'LANGUAGE': 'en_US:en', 08:21:34 INFO - 'LOGNAME': 'cltbld', 08:21:34 INFO - 'MAIL': '/var/mail/cltbld', 08:21:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:34 INFO - 'MOZ_NO_REMOTE': '1', 08:21:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:34 INFO - 'NO_EM_RESTART': '1', 08:21:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:34 INFO - 'PWD': '/builds/slave/test', 08:21:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:34 INFO - 'SHELL': '/bin/bash', 08:21:34 INFO - 'SHLVL': '1', 08:21:34 INFO - 'TERM': 'linux', 08:21:34 INFO - 'TMOUT': '86400', 08:21:34 INFO - 'USER': 'cltbld', 08:21:34 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219', 08:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:34 INFO - '_': '/tools/buildbot/bin/python'} 08:21:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 08:21:34 INFO - mozversion INFO | application_buildid: 20151215070825 08:21:34 INFO - mozversion INFO | application_changeset: 0fb60a06349bce8b13f7f7d3c31305af13320b77 08:21:34 INFO - mozversion INFO | application_display_name: Nightly 08:21:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:34 INFO - mozversion INFO | application_name: Firefox 08:21:34 INFO - mozversion INFO | application_remotingname: firefox 08:21:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:21:34 INFO - mozversion INFO | application_vendor: Mozilla 08:21:34 INFO - mozversion INFO | application_version: 46.0a1 08:21:34 INFO - mozversion INFO | platform_buildid: 20151215070825 08:21:34 INFO - mozversion INFO | platform_changeset: 0fb60a06349bce8b13f7f7d3c31305af13320b77 08:21:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:21:34 INFO - mozversion INFO | platform_version: 46.0a1 08:21:34 INFO - 2015-12-15 08:21:34,330 DEBUG : using testdate: 1450196494 08:21:34 INFO - 2015-12-15 08:21:34,330 DEBUG : actual date: 1450196494 08:21:34 INFO - 2015-12-15 08:21:34,341 INFO : starting webserver on 'localhost:40236' 08:21:34 INFO - 2015-12-15 08:21:34,342 INFO : Starting test suite talos-linux64-ix-019 08:21:34 INFO - 2015-12-15 08:21:34,343 INFO : Starting test dromaeo_css 08:21:34 INFO - 2015-12-15 08:21:34,343 DEBUG : operating with platform_type : linux_ 08:21:34 INFO - 2015-12-15 08:21:34,343 INFO : Initialising browser for dromaeo_css test... 08:21:34 INFO - 2015-12-15 08:21:34,359 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEYnu0h/profile http://localhost:40236/getInfo.html 08:21:39 INFO - 2015-12-15 08:21:39,023 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:21:39 INFO - 2015-12-15 08:21:39,024 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:21:39 INFO - 2015-12-15 08:21:39,024 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:21:39 INFO - 2015-12-15 08:21:39,024 DEBUG : BROWSER_OUTPUT: __metrics 08:21:39 INFO - 2015-12-15 08:21:39,100 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:21:39 INFO - 2015-12-15 08:21:39,168 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:40 INFO - 2015-12-15 08:21:40,029 INFO : Browser initialized. 08:21:40 INFO - 2015-12-15 08:21:40,030 INFO : Running cycle 1/1 for dromaeo_css test... 08:21:40 INFO - 2015-12-15 08:21:40,030 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEYnu0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:21:52 INFO - 2015-12-15 08:21:52,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 142524416 08:21:52 INFO - 2015-12-15 08:21:52,004 DEBUG : BROWSER_OUTPUT: 08:22:43 INFO - 2015-12-15 08:22:43,489 DEBUG : BROWSER_OUTPUT: 1450196563482 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] 08:24:55 INFO - 2015-12-15 08:24:55,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40236/tests/dromaeo/cssquery-ext.html) 08:24:56 INFO - 2015-12-15 08:24:56,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 260747264 08:24:56 INFO - 2015-12-15 08:24:56,621 DEBUG : BROWSER_OUTPUT: 08:27:59 INFO - 2015-12-15 08:27:59,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-ext.html (next: http://localhost:40236/tests/dromaeo/cssquery-jquery.html) 08:27:59 INFO - 2015-12-15 08:27:59,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 228143104 08:27:59 INFO - 2015-12-15 08:27:59,716 DEBUG : BROWSER_OUTPUT: 08:31:01 INFO - 2015-12-15 08:31:01,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40236/tests/dromaeo/cssquery-mootools.html) 08:31:02 INFO - 2015-12-15 08:31:02,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 227905536 08:31:02 INFO - 2015-12-15 08:31:02,339 DEBUG : BROWSER_OUTPUT: 08:34:04 INFO - 2015-12-15 08:34:04,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40236/tests/dromaeo/cssquery-prototype.html) 08:34:04 INFO - 2015-12-15 08:34:04,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 204775424 08:34:04 INFO - 2015-12-15 08:34:04,864 DEBUG : BROWSER_OUTPUT: 08:37:07 INFO - 2015-12-15 08:37:07,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40236/tests/dromaeo/cssquery-yui.html) 08:37:08 INFO - 2015-12-15 08:37:08,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 210448384 08:37:08 INFO - 2015-12-15 08:37:08,159 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-12-15 08:40:10,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/dromaeo/cssquery-yui.html (next: http://localhost:40236/tests/dromaeo/cssquery-dojo.html) 08:40:10 INFO - 2015-12-15 08:40:10,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 233222144 08:40:10 INFO - 2015-12-15 08:40:10,993 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-12-15 08:40:10,994 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:40:10 INFO - 2015-12-15 08:40:10,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:40:10 INFO - 2015-12-15 08:40:10,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:40:10 INFO - 2015-12-15 08:40:10,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:40:10 INFO - 2015-12-15 08:40:10,996 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2649.841009539428;2730.4266104118133;2736.138116493306;2751.353431943493;2751.95872061919;4529.977350113245;4644.187267228239;4755.239161734124;4782.808687652494;4792.161371759941;4668.066386722652;4690.460597031342;4802.951970480294;4804.61563074954;4805.711657300564;4377.124575084979;4388.626966707834;4409.757463339515;4458.063806600618;4494.640428765691;4414.359917811916;4459.955400446002;4484.798184081724;4492.910141797162;4521.525239849818;4204.516480604724;4253.999999999969;4310.116426132635;4326.805293761757;4370.868873933787;4319.308910574325;4368.082702632451;4381.058072514393;4384.079343337903;4407.603315701603;4156.688248381383;4324.1567894260315;4344.196323680129;4357.782110894443;4397.824087036514;4530.501644819067;4569.086182763461;4593.19619066662;4690.812367505296;4739.265413860857;5063.341765570489;5089.592832573422;5091.159958606825;5091.821786237501;5139.331886854685;4827.131116399047;5082.2122571001555;5118;5124.743762811844;5130.666506677091;4673.065386922629;4681.999999999966;4687.953120468752;4759.738214398172;4829.227323628203;5205.817796377109;5227.817026404057;5229.816956406507;5232.92150617741;5284.154535274338;4756.571908528249;5025.874353141201;5026.84919452417;5030.0694371541385;5079.771410286546;4967.503249675004;5025.748712564357;5038.067957427887;5083.466236045236;5102.770375333119;5043.873903152377;5074.720890351066;5078.289039534468;5084.898302033938;5135.563477104413;4808.63935204861;5052.520010598987;5056.393232812086;5056.443791182967;5062.4684408137355;4141.399497072907;4142.2958097123565;4164.146349998243;4220.430241917302;4272.5086615039045;3686.4713643714044;3689.0408493791806;3689.9815500922323;3716.5168528091717;3729.701623870084;4174.853880114181;4349.934750978738;4353.3469979503325;4354.651627869763;4395.912081758347;4957.677750946177;4974.054929563371;5034.194528875362;5061.493850614909;5103.693778373309;4370.169667763115;4372.060007098489;4376.803043863034;4381.78091095444;4436.134953684001;4285.142971405669;4523.25366314561;4527.615152712056;4528.343390208467;4567.885802854955;4656.348111264493;4713.764311784397;4736.123817093849;4740.9051818962735;4792.065547218259;5080.796768129233;5087.821926232564;5090.185570308733;5092.898142037213;5143.665661731976;4672.08894265615;4803.543663351976;4806.759662016955;4810.158222311012;4854.8786280341865;4879.121758083579;4915.926261106158;4928.334674818853;4950.752462376939;4999.775010124626;5092.567131793839;5113.360829896263;5118.41138269089;5125.538701516882;5159;4741.668083234141;4937.259411088366;4945.035718034948;4948;4949.9257511138085;4817.78319975595;4857.53853383928;4881.731504767272;4882.145624515767;4897.338859253955;4764.9047019058735;4776.116418462596;4777.3072904429355;4783.617310615073;4811.927821082617;4717.315989181481;4885.560299573055;4895.877603059952;4899.265110233494;4923.433805112458;4714.9292760609305;4738.31294462308;4755.429348478205;4775.594074503706;4829.275608658589 08:40:11 INFO - 2015-12-15 08:40:10,999 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.3708452160363;569.9373068962411;572.4733245414219;581.3895409819689;581.9912701309481;27596.172114836536;28099.29751756207;28161.155165345048;35678;36656.63343366566;40211.597884021154;40555.79722101393;40641;40692.796536017355;40712.38931416031;7983.720569780074;8142.348612111046;8147.307478864274;8152.2662960333555;8153.266206041455;7052.929470705304;7143.714251429962;10124.088832005118;10373;10409.21930855185;10142.340747851365;10245;10247.436390998491;10263.178945684365;10279.640212592562;9833.213342932548;9897.15874150698;9921.355111917774;9923.900760992443;9925.255605829556;9950.35322704022;9973.950130249303;10012.849807252896;10099.444530550816;10104.595816167344;37089.443658345146;37507.62492375096;37521.43717844234;37573;37596.62403375959;2856.9285767855763;2893.8263704177816;2904.4917139500503;2917.562365645149;2918.1245626312234;28049.298767530974;28112.859435702896;28167.436651267064;28271.57592636112;29205.123846284434;2660.8270462419882;2708.214617760847;2719.877605507757;2772.3900741836765;2777.4583956128563;219228;219236;219241;219735;219974;49312.26031609457;50294;53277.200841987404;53582;53641;63057.68471157615;64064.67967660132;64246;64285;64327.35672643307;12378.195417297848;12652.43064062101;12689.682757931125;12710.237385756884;12710.872891271154;8352.081271060179;8643.265322447662;9500.097490738368;9593.232541396672;9725.805483890425;18027;18102.90948545249;18147;18163.54591135206;18221.54446138857;7270.781876543606;7370.852582948311;7540.341124952502;7551.358134558624;7565.659545320474;821.2731732416854;889.7953470701775;957.8134402211945;970.7184916374314;1011.7976404718938;26401.207963761117;26481.74905133085;26913;26924.192274231806;26945.595816062774;939.1594522901964;971.3637567393368;973.4354074636693;993.1260490768078;1066.919981001428;13704.177749334873;13953.790693139612;14853.48012819546;14886.404543818126;15107.39570417193;300357;300358;302442;302844;305125;48229;48493;48696.75651621719;48758.26862597064;48800.26799598009;1233.2353940556911;1240.7518496300777;1240.8076748104058;1247.1457051919465;1251.4431078170128;27485;28511;28772;28922.566161507173;29033.564496532992;41063.38404923988;41535.58464415317;41575.168496629296;41610.37584436296;41631.167376652906;242779;245574;246569;246659;247404;25214.24357269285;25625.796775403076;29043.7095629041;29179.562306565844;29329.266768330963;33924.49113263254;34219.65780342264;34265.314693705484;34739.305213896085;34856.82571587126;28874.711252887202;29256.414871702873;29260.707392926648;29546.704532954394;29856.25359366033;28124;31135.532967005965;31674.841625791723;31692.683073169894;32428.513572296906;29530.557041643962;29875.253118672208;29905.401891962472;35042.649573503935;35677.82161089178;27705;29586.556201656564;30318.393632127674;31933.882314118895;34732.65267347294;23197.304080877602;23562.882185588962;26702.332441689112;26822;26931.596026060015 08:40:11 INFO - 2015-12-15 08:40:11,000 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.3632761425676;334.25794735686765;337.7652531490612;338.5936875749101;341.1199106305731;8448.91551084489;8728.738137855858;10400.323978941373;14756.6310842229;15138.864585156116;14891.478798242064;15288.464903728373;15488.457903973363;16290.42983495578;16293.266802993865;4562.156001139783;5594.216809646653;5774.393688662672;5802.216700745409;5817.650940943536;5821.214136091616;5866.911996320037;5867.562447200442;5869.060950247961;5876.559258055641;5718.914216286759;5843.918875008138;5849.473547380735;5849.7660093596205;5855.76576936922;5691.743871525791;5719.885602287931;5727.312722473288;5728.42715728428;5736.368999410082;5391.568674506069;5571.637843540157;5573.5819813514145;5579.218909352694;5582.8325150245555;20803.06386212624;20901.477463063544;20980.790192098037;21037.89481052585;21420.25029123989;1956.4424139120283;2092.7070210170587;2095.758987716402;2102;2128.7658357580654;13765.862341376558;13850.09974351664;13866.722665546733;14016.719665606734;14149.85850141506;1901.2204995951593;1929.0836852495092;1930.4691209917244;1989.34351663952;1995.860289779716;56524.43475565233;63337.683311583605;64917;64923.35076649267;65080.3491965079;15003.399864005536;15325.157116358485;15351.846481535265;15356.616084597974;15363.846361536242;18552.165152568166;19153.233870645297;20112.69267497608;23173.188938387077;23183;7757.806054848561;7909.288164065147;8214.383921205934;8282.751517454486;8287.254147126787;6772.966135169293;6788.253292137861;6812.659367031629;6827.69275382609;6866.038754574363;7517.436192285601;7521.398288136936;7530.246975302426;7536.886946695804;7548.999515128496;2859.9857000714865;2929.692382299828;2940.9411811763644;2964.8517574121206;2974.3159073413235;814.8288859339486;904.9864252036225;908.6229214875884;934.5047125023748;995.9253056020827;14907.329170187368;15305.928584999167;15720.528384148494;15866.44467443634;16166.35334586627;829.8092237639007;838.86997515384;865.3034307382618;882.7837179890839;884.6947803007952;7211.411156353763;7533.924660753432;8440.238695662956;8763.780905477413;8873.600687969058;467806;471132;477214;479060;483516;60988.39011609916;62345.68827155926;62442.687786561684;64379.35620643827;75487.62256188683;932.14242896534;1068.6855168143072;1082.188358730936;1128.915331350152;1131.3947038334616;13597.79603305971;14618.713299731295;14678.559643210721;14697.118172909659;14844.035137716013;29844.70155298506;30496.542551862185;30788.53817192789;31264.687353126177;31466.213344666565;38404.80797595994;40243.597564023985;42716.57283427126;43522.78238608786;44199.33700994552;8806.691765788166;8961.23829474502;9246.722598322061;9256.07439256069;9263.53682315895;16118.838811612202;16192.352305907632;16303.103329317002;16472.752908706618;16989.40537081196;13604.319784010957;13855.653608659864;13999.44002239899;14091.788623170865;14099.718005640036;13458.663533411744;13670.93164534171;13762.174269543859;13980.580582582132;14175.22036288014;13384.130031547918;14187.219702916438;14223.502177423741;14621.342039608457;14664.120152790867;8946.507942063248;9088.09119088086;9094.408863423856;9167.44995300284;9170.174684278447;13370.799438008244;13496;13684.178949263076;14124.50564230247;14257.928710356382 08:40:11 INFO - 2015-12-15 08:40:11,003 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.084909384353;1404.7682132448147;1416.9929150354253;1620.2546828458908;1685.334292954283;5739;6983.196932352781;7164.319389657987;7166.211716711157;7179.533330333525;7020.894686579705;7152;7176.461765367605;7178;7206;1706.991465042673;1725.4737305121996;2030.0966070098812;2046.2122082998042;2076.896155192242;2059.907304171308;2060.453979695382;2062.845286603503;2067.0904801887195;2067.6588362920174;2032.5833204193104;2046.2122082998003;2098.7586427560796;2101.023024293703;2103.432073340205;2016.7075774012685;2026.2907982206257;2042.0198304813623;2050.569380430104;2058.2281644383356;2076.283682129663;2093.979060209409;2096.15105882118;2096.7693553709078;2098.4019554426914;7247.31150540703;7334.193238743734;7343.192248852622;7346.228645992147;7351.77944661661;3953.8418463261437;4017.2568074905944;4029.6977726670616;4044.69664775143;4049.8785036448953;2657.4419371931917;2689.421774318531;2743.43759529296;2745.23133522614;2747.2719729271757;821.2526600793309;827.6606591297539;833.1085738260064;862.8791969124328;865.0614083719172;9710.514474276328;9710.6115755369;9722.75693107678;9741.123298903061;9741.853872191923;3817.560980487224;3873.748206366577;3997.8001099944886;4000.899977500586;4004.2992476316526;8398.622062007224;8415.200555947175;8417.747467575982;8425.115362886809;8436.409451338348;4173.08192197716;4184.121334519724;4186.413902053715;4188.434561334242;4189.958100419018;3761.1725420407465;3788.4696142540065;3788.6969042476535;3799.810009499514;3800.562935262425;3053.5724998500227;3110.3001824589737;3316.403047451434;3359.8320083995704;3499.772514786531;1093.147345070846;1100.510272928539;1122.1639878290725;1128.565502281611;1136.5226604825828;940.7930255343813;942.0673533202081;1000.7348052766023;1022.9181665466893;1203.5967950736601;6849.383555480031;6883.380495755406;6904.067950826675;6906.758263460855;6909.619970901548;963.272729089533;973.3138137612966;999.9950000249952;1054.9208809339177;1075.6665433715416;5372.462753724596;5420.972895135578;5425;5438.15708565173;5438.728063596884;8484.745457636282;8543.145685431531;8650.43772154808;8714.172153645393;8775.517346545874;8608.09614990417;8682.262007729414;8688.087750786077;8704.738857834149;8707.695230666895;6731.259561448237;6782.389584937379;6819.352161544645;6893.586384816927;6936.895946560705;6564.081028656087;6576.671166441563;6578.144841170617;6583.177102862142;6591.571547849375;7522.210167932507;7733.110692270461;7749.41879359039;7784.41616878725;7785.805354865947;7811.414143939113;7856.135825059125;8045.396595255263;8127.959360203161;8130.2682758549645;6412.61524308543;6414.454771344302;6466.644334561644;6481;6481.902771458337;5501.229827824188;5644.294463192101;6478.611283323015;6719;6977.372036516738;6259.687015649109;6283.2774230962195;6297.874042519215;6379.234491861006;6395.968020159869;6129.417705317987;6298.71655775482;6426.775062872777;6428.6785660717715;6655.201375834931;6482.092507048923;6489.513286503626;6492.091107245084;6499.6750162492635;6516.837079073061;6033.78881739137;6065.090236464565;6073.605215660968;6078.483328916915;6086.2087928569;5865.384134665798;6121.3572574879;6171.228596425447;6178.474829639351;6215.627062376272 08:40:11 INFO - 2015-12-15 08:40:11,004 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.47171412172787;294.20564475915023;298.31238994118564;299.07734638639795;299.5237572260106;5270.183121616151;5302.4697530247;5307.628466007381;5311;5321.547668448186;5024.723640199788;5060.6204534659955;5155.149400348947;5238.685678859271;5256.763445644946;4097.344424892018;4110.588941105895;4120.25835349637;4124.133931874302;4129.793510324472;3888.1251718363283;4114.19773144237;4115.979420102895;4123.9381409278885;4129.236091323115;3954.5254569451704;4004.479417675698;4099.856505022325;4114.7119701620895;4114.876553703393;4077.7757223352705;4087.4073259377224;4089.591040895916;4091.099958009248;4103.466549348595;3588.4976103345552;3604.1350075981836;3611.205534782344;3616.385214513539;3619.1133172372674;5129.820456284049;5141.357330333708;5142.202958541432;5147.871303217412;5148.330717006803;4502.977485112586;4636.165490211761;4641.907161856744;4648.721076735373;4697.224957881946;5555.3333599967855;5569.359523654791;5570.777168913239;5571.164325351189;5572.832815015556;3813.31360355136;3817.675497582709;3826.1773718650625;3829.8276577554075;3830.425436184567;5765.769369225226;5812.767489300465;5824.534037277008;5826.533877289807;5840.328362238354;3789.1629938376223;3863.74885632433;3919.6080391960577;3922.764634121962;3938.4092386141733;3976.7812770297332;3977.125032492847;3979.184267225212;3983.5618082010956;3983.820728067244;4566.931496027496;4575.450945886515;4584.266517357207;4584.908301833944;4604.746738929391;5555.333359996826;5560.193771903051;5562.972185139049;5567.8886422272135;5577.776888924479;1369.5685858954398;1373.7801951687882;1396.294871090093;1398.9090709103875;1400.7128538649552;924.505389616552;944.5230158769778;947.303731757158;953.618552578974;954.2270760683869;4835.854924352205;4869.9513004870205;4876.439209490883;4878.0975519529;4879.926801097987;5779.942200578024;5788.0739081746715;5789.9710501447225;5791.536677065825;5793.768249270066;4701.388819453449;4794.065157294364;4797.880052998633;4871.610271178297;4918.458969513351;3107.90676279712;3117.1895307220284;3127.4526957782296;3132.483140281828;3138.4350816853184;5462.071447853875;5474.863128421742;5477.808276710296;5482.835514934558;5491.588130890199;5823.79616713413;5971.164037034819;5973.581849270597;5974.671393073336;5978.701064946822;5492.945070549324;5493.121100623881;5498.615096943256;5501.834944951578;5510.338759348904;5846.883062338815;5852.970735146297;5854.648721076749;5858.765649373977;5860.443257890493;5717.942820571741;5728.570357223141;5730.627509212055;5731.971340143273;5741.25363702716;5363.410024897336;5501.477359650827;5507.421720719267;5511.255980442589;5512.91730624033;3911.647951684362;3942.2706799242233;3947.0921688011344;3953.169834334822;3956.8615098471414;5831.94168058314;5839.678817665069;5840.532757379485;5841.591088623755;5842.38654941225;5454.4545545445135;5620.634658747168;5625.634333768292;5631.521320687787;5635.154726791015;5587.664740115606;5592.69240191777;5596.132599447093;5599.160125980972;5608.747606357805;5481.095619222943;5484.753186106555;5487.506124448819;5488.094464413327;5495.203195536545;5634;5643.068893632505;5646.548276137817;5647.463490968352;5651.632643878134;5384.703841288767;5491.478309560745;5502.8349149525575;5506.752196151263;5515.172724091419 08:40:11 INFO - 2015-12-15 08:40:11,004 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.582558377765;740.988885166723;745.0649434959125;774.6320497763561;783.8471498057879;10908.400037997917;11080.05819505343;11089.05743011843;11091.389973551462;11131.109511239101;11161.83257251142;11203.103751699864;11246.100311975042;11268.211225214238;11276.492557834896;616.2697203813473;623.1276213301392;763.7479631721533;764.7667461424263;781.9335356494705;772.4399810137661;773.8529679360931;781.679511400326;782.2060608482395;783.4594130050247;642.2068745099822;815.7104227999064;823.7858156879195;823.8764185372182;824.2416976381713;647.8963365861463;803.7669075967963;817.3461231015164;817.546261824687;817.5830326533481;603.5865432178972;606.4935778624854;606.7754930675678;609.0194786393902;609.454538188319;10730.785384292349;10778.137748980063;10830;10849.566017359297;10893.237473376867;10362.585496580203;10550.15598752098;10720.678379648623;10781.245312828105;10849.837252441219;8725.607347669371;8820;9073.818523629556;9094.545272736337;9221.262299016063;3231.74146068314;3262.4943133814295;3291.555639988595;3317.10438181692;3384.272381437978;37724.43413348802;37953.62046379556;38053.619463805284;38065.61934380649;38172;7910.16943220965;8140.75577732669;8323.1260717625;8425;8617.922759655043;14117.08238964464;14135.293235338191;14169.858301416854;14193.574192774233;14244.07413518118;6211.782587609412;6250.656213908279;6360.6501642409185;6474.546781725328;6504.5121615879;3343.348047130835;3418.418868792311;3441.483777433405;3446.5347178130633;3454.084667563098;2575.729548397429;2605.4398304364654;2608.9478210435686;2610.973890261111;2612.5166844133896;452.6265830689694;460.8709561322835;468.7820163623931;471.66747443052566;474.0542617478153;467.67262915958963;470.82344120954644;486.65190456049703;512.5720023780111;548.1667864845413;6942.479314051467;6975.093237879043;7014.789556313319;7164.176119746192;7186.928130718626;434.3137842209302;481.379021062832;528.4213785904428;539.4120408754477;547.6960287040731;3206.8075915445147;3231.0629917323713;3246.9188270292957;3348.330333933174;3349.43059679855;47866;48612;48901.266481002815;48937.75531122321;48970.510294896594;43985.12029759387;44215.55784442179;44972.77513612411;44978.325325120146;45130.77434612872;39290.80354598266;40339.596604033584;40507.79746101251;40554;40874.38688419676;6727.663616819237;6776.525643204928;6920.688569014507;7465.776026719207;7610.733624323122;29290.853545732134;30496;31033;31401.214969625944;31535.684643153276;37350.75895446282;37945;38560.6143938557;38564.22871542497;38775.418368725055;9051.185393314634;9616.326857119935;9753.073458021476;9873.802523949336;9963.352382095141;10457.68626941193;10501.159907207253;10614.991575800286;10832.837507437238;10976.396298203355;9560.713178604654;10155.187584993035;10232;10358.067773900386;10660.46697665129;10108.898911010796;10124.645637402655;10140;10169.237307201842;10324.43215623118;9857.408555486694;10134;10376.465665813275;10582.894171058191;10905.890941090805;8341.791455213668;8455.492670439793;8655.48067115975;8805;9350.205232555309;8408.83182336362;8710.259627931697;8777.736667899973;8806.86789698168;8950.14973577509 08:40:11 INFO - 2015-12-15 08:40:11,004 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:40:11 INFO - 2015-12-15 08:40:11,005 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:40:11 INFO - 2015-12-15 08:40:11,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 08:40:11 INFO - 2015-12-15 08:40:11,005 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:40:11 INFO - 2015-12-15 08:40:11,005 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197610993__endTimestamp 08:40:11 INFO - 2015-12-15 08:40:11,005 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:40:11 INFO - 2015-12-15 08:40:11,006 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4663.29 Median:4776.12 stddev:484.79 (10.2%) stddev-sans-first:459.83 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: Values: 2649.8 2730.4 2736.1 2751.4 2752.0 4530.0 4644.2 4755.2 4782.8 4792.2 4668.1 4690.5 4803.0 4804.6 4805.7 4377.1 4388.6 4409.8 4458.1 4494.6 4414.4 4460.0 4484.8 4492.9 4521.5 4204.5 4254.0 4310.1 4326.8 4370.9 4319.3 4368.1 4381.1 4384.1 4407.6 4156.7 4324.2 4344.2 4357.8 4397.8 4530.5 4569.1 4593.2 4690.8 4739.3 5063.3 5089.6 5091.2 5091.8 5139.3 4827.1 5082.2 5118.0 5124.7 5130.7 4673.1 4682.0 4688.0 4759.7 4829.2 5205.8 5227.8 5229.8 5232.9 5284.2 4756.6 5025.9 5026.8 5030.1 5079.8 4967.5 5025.7 5038.1 5083.5 5102.8 5043.9 5074.7 5078.3 5084.9 5135.6 4808.6 5052.5 5056.4 5056.4 5062.5 4141.4 4142.3 4164.1 4220.4 4272.5 3686.5 3689.0 3690.0 3716.5 3729.7 4174.9 4349.9 4353.3 4354.7 4395.9 4957.7 4974.1 5034.2 5061.5 5103.7 4370.2 4372.1 4376.8 4381.8 4436.1 4285.1 4523.3 4527.6 4528.3 4567.9 4656.3 4713.8 4736.1 4740.9 4792.1 5080.8 5087.8 5090.2 5092.9 5143.7 4672.1 4803.5 4806.8 4810.2 4854.9 4879.1 4915.9 4928.3 4950.8 4999.8 5092.6 5113.4 5118.4 5125.5 5159.0 4741.7 4937.3 4945.0 4948.0 4949.9 4817.8 4857.5 4881.7 4882.1 4897.3 4764.9 4776.1 4777.3 4783.6 4811.9 4717.3 4885.6 4895.9 4899.3 4923.4 4714.9 4738.3 4755.4 4775.6 4829.3 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41550.02 Median:29890.33 stddev:67430.37 (225.6%) stddev-sans-first:67549.33 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: Values: 569.4 569.9 572.5 581.4 582.0 27596.2 28099.3 28161.2 35678.0 36656.6 40211.6 40555.8 40641.0 40692.8 40712.4 7983.7 8142.3 8147.3 8152.3 8153.3 7052.9 7143.7 10124.1 10373.0 10409.2 10142.3 10245.0 10247.4 10263.2 10279.6 9833.2 9897.2 9921.4 9923.9 9925.3 9950.4 9974.0 10012.8 10099.4 10104.6 37089.4 37507.6 37521.4 37573.0 37596.6 2856.9 2893.8 2904.5 2917.6 2918.1 28049.3 28112.9 28167.4 28271.6 29205.1 2660.8 2708.2 2719.9 2772.4 2777.5 219228.0 219236.0 219241.0 219735.0 219974.0 49312.3 50294.0 53277.2 53582.0 53641.0 63057.7 64064.7 64246.0 64285.0 64327.4 12378.2 12652.4 12689.7 12710.2 12710.9 8352.1 8643.3 9500.1 9593.2 9725.8 18027.0 18102.9 18147.0 18163.5 18221.5 7270.8 7370.9 7540.3 7551.4 7565.7 821.3 889.8 957.8 970.7 1011.8 26401.2 26481.7 26913.0 26924.2 26945.6 939.2 971.4 973.4 993.1 1066.9 13704.2 13953.8 14853.5 14886.4 15107.4 300357.0 300358.0 302442.0 302844.0 305125.0 48229.0 48493.0 48696.8 48758.3 48800.3 1233.2 1240.8 1240.8 1247.1 1251.4 27485.0 28511.0 28772.0 28922.6 29033.6 41063.4 41535.6 41575.2 41610.4 41631.2 242779.0 245574.0 246569.0 246659.0 247404.0 25214.2 25625.8 29043.7 29179.6 29329.3 33924.5 34219.7 34265.3 34739.3 34856.8 28874.7 29256.4 29260.7 29546.7 29856.3 28124.0 31135.5 31674.8 31692.7 32428.5 29530.6 29875.3 29905.4 35042.6 35677.8 27705.0 29586.6 30318.4 31933.9 34732.7 23197.3 23562.9 26702.3 26822.0 26931.6 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,007 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26785.21 Median:339.86 stddev:77542.42 (22816.2%) stddev-sans-first:77734.51 08:40:11 INFO - 2015-12-15 08:40:11,008 DEBUG : BROWSER_OUTPUT: Values: 333.4 334.3 337.8 338.6 341.1 8448.9 8728.7 10400.3 14756.6 15138.9 14891.5 15288.5 15488.5 16290.4 16293.3 4562.2 5594.2 5774.4 5802.2 5817.7 5821.2 5866.9 5867.6 5869.1 5876.6 5718.9 5843.9 5849.5 5849.8 5855.8 5691.7 5719.9 5727.3 5728.4 5736.4 5391.6 5571.6 5573.6 5579.2 5582.8 20803.1 20901.5 20980.8 21037.9 21420.3 1956.4 2092.7 2095.8 2102.0 2128.8 13765.9 13850.1 13866.7 14016.7 14149.9 1901.2 1929.1 1930.5 1989.3 1995.9 56524.4 63337.7 64917.0 64923.4 65080.3 15003.4 15325.2 15351.8 15356.6 15363.8 18552.2 19153.2 20112.7 23173.2 23183.0 7757.8 7909.3 8214.4 8282.8 8287.3 6773.0 6788.3 6812.7 6827.7 6866.0 7517.4 7521.4 7530.2 7536.9 7549.0 2860.0 2929.7 2940.9 2964.9 2974.3 814.8 905.0 908.6 934.5 995.9 14907.3 15305.9 15720.5 15866.4 16166.4 829.8 838.9 865.3 882.8 884.7 7211.4 7533.9 8440.2 8763.8 8873.6 467806.0 471132.0 477214.0 479060.0 483516.0 60988.4 62345.7 62442.7 64379.4 75487.6 932.1 1068.7 1082.2 1128.9 1131.4 13597.8 14618.7 14678.6 14697.1 14844.0 29844.7 30496.5 30788.5 31264.7 31466.2 38404.8 40243.6 42716.6 43522.8 44199.3 8806.7 8961.2 9246.7 9256.1 9263.5 16118.8 16192.4 16303.1 16472.8 16989.4 13604.3 13855.7 13999.4 14091.8 14099.7 13458.7 13670.9 13762.2 13980.6 14175.2 13384.1 14187.2 14223.5 14621.3 14664.1 8946.5 9088.1 9094.4 9167.4 9170.2 13370.8 13496.0 13684.2 14124.5 14257.9 08:40:11 INFO - 2015-12-15 08:40:11,008 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,008 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4997.37 Median:6290.58 stddev:2619.18 (41.6%) stddev-sans-first:2612.55 08:40:11 INFO - 2015-12-15 08:40:11,009 DEBUG : BROWSER_OUTPUT: Values: 1397.1 1404.8 1417.0 1620.3 1685.3 5739.0 6983.2 7164.3 7166.2 7179.5 7020.9 7152.0 7176.5 7178.0 7206.0 1707.0 1725.5 2030.1 2046.2 2076.9 2059.9 2060.5 2062.8 2067.1 2067.7 2032.6 2046.2 2098.8 2101.0 2103.4 2016.7 2026.3 2042.0 2050.6 2058.2 2076.3 2094.0 2096.2 2096.8 2098.4 7247.3 7334.2 7343.2 7346.2 7351.8 3953.8 4017.3 4029.7 4044.7 4049.9 2657.4 2689.4 2743.4 2745.2 2747.3 821.3 827.7 833.1 862.9 865.1 9710.5 9710.6 9722.8 9741.1 9741.9 3817.6 3873.7 3997.8 4000.9 4004.3 8398.6 8415.2 8417.7 8425.1 8436.4 4173.1 4184.1 4186.4 4188.4 4190.0 3761.2 3788.5 3788.7 3799.8 3800.6 3053.6 3110.3 3316.4 3359.8 3499.8 1093.1 1100.5 1122.2 1128.6 1136.5 940.8 942.1 1000.7 1022.9 1203.6 6849.4 6883.4 6904.1 6906.8 6909.6 963.3 973.3 1000.0 1054.9 1075.7 5372.5 5421.0 5425.0 5438.2 5438.7 8484.7 8543.1 8650.4 8714.2 8775.5 8608.1 8682.3 8688.1 8704.7 8707.7 6731.3 6782.4 6819.4 6893.6 6936.9 6564.1 6576.7 6578.1 6583.2 6591.6 7522.2 7733.1 7749.4 7784.4 7785.8 7811.4 7856.1 8045.4 8128.0 8130.3 6412.6 6414.5 6466.6 6481.0 6481.9 5501.2 5644.3 6478.6 6719.0 6977.4 6259.7 6283.3 6297.9 6379.2 6396.0 6129.4 6298.7 6426.8 6428.7 6655.2 6482.1 6489.5 6492.1 6499.7 6516.8 6033.8 6065.1 6073.6 6078.5 6086.2 5865.4 6121.4 6171.2 6178.5 6215.6 08:40:11 INFO - 2015-12-15 08:40:11,009 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,010 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4616.11 Median:5286.33 stddev:1373.53 (26.0%) stddev-sans-first:1338.44 08:40:11 INFO - 2015-12-15 08:40:11,010 DEBUG : BROWSER_OUTPUT: Values: 289.5 294.2 298.3 299.1 299.5 5270.2 5302.5 5307.6 5311.0 5321.5 5024.7 5060.6 5155.1 5238.7 5256.8 4097.3 4110.6 4120.3 4124.1 4129.8 3888.1 4114.2 4116.0 4123.9 4129.2 3954.5 4004.5 4099.9 4114.7 4114.9 4077.8 4087.4 4089.6 4091.1 4103.5 3588.5 3604.1 3611.2 3616.4 3619.1 5129.8 5141.4 5142.2 5147.9 5148.3 4503.0 4636.2 4641.9 4648.7 4697.2 5555.3 5569.4 5570.8 5571.2 5572.8 3813.3 3817.7 3826.2 3829.8 3830.4 5765.8 5812.8 5824.5 5826.5 5840.3 3789.2 3863.7 3919.6 3922.8 3938.4 3976.8 3977.1 3979.2 3983.6 3983.8 4566.9 4575.5 4584.3 4584.9 4604.7 5555.3 5560.2 5563.0 5567.9 5577.8 1369.6 1373.8 1396.3 1398.9 1400.7 924.5 944.5 947.3 953.6 954.2 4835.9 4870.0 4876.4 4878.1 4879.9 5779.9 5788.1 5790.0 5791.5 5793.8 4701.4 4794.1 4797.9 4871.6 4918.5 3107.9 3117.2 3127.5 3132.5 3138.4 5462.1 5474.9 5477.8 5482.8 5491.6 5823.8 5971.2 5973.6 5974.7 5978.7 5492.9 5493.1 5498.6 5501.8 5510.3 5846.9 5853.0 5854.6 5858.8 5860.4 5717.9 5728.6 5730.6 5732.0 5741.3 5363.4 5501.5 5507.4 5511.3 5512.9 3911.6 3942.3 3947.1 3953.2 3956.9 5831.9 5839.7 5840.5 5841.6 5842.4 5454.5 5620.6 5625.6 5631.5 5635.2 5587.7 5592.7 5596.1 5599.2 5608.7 5481.1 5484.8 5487.5 5488.1 5495.2 5634.0 5643.1 5646.5 5647.5 5651.6 5384.7 5491.5 5502.8 5506.8 5515.2 08:40:11 INFO - 2015-12-15 08:40:11,010 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,010 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11759.13 Median:464.27 stddev:13527.53 (2913.7%) stddev-sans-first:13539.99 08:40:11 INFO - 2015-12-15 08:40:11,011 DEBUG : BROWSER_OUTPUT: Values: 701.6 741.0 745.1 774.6 783.8 10908.4 11080.1 11089.1 11091.4 11131.1 11161.8 11203.1 11246.1 11268.2 11276.5 616.3 623.1 763.7 764.8 781.9 772.4 773.9 781.7 782.2 783.5 642.2 815.7 823.8 823.9 824.2 647.9 803.8 817.3 817.5 817.6 603.6 606.5 606.8 609.0 609.5 10730.8 10778.1 10830.0 10849.6 10893.2 10362.6 10550.2 10720.7 10781.2 10849.8 8725.6 8820.0 9073.8 9094.5 9221.3 3231.7 3262.5 3291.6 3317.1 3384.3 37724.4 37953.6 38053.6 38065.6 38172.0 7910.2 8140.8 8323.1 8425.0 8617.9 14117.1 14135.3 14169.9 14193.6 14244.1 6211.8 6250.7 6360.7 6474.5 6504.5 3343.3 3418.4 3441.5 3446.5 3454.1 2575.7 2605.4 2608.9 2611.0 2612.5 452.6 460.9 468.8 471.7 474.1 467.7 470.8 486.7 512.6 548.2 6942.5 6975.1 7014.8 7164.2 7186.9 434.3 481.4 528.4 539.4 547.7 3206.8 3231.1 3246.9 3348.3 3349.4 47866.0 48612.0 48901.3 48937.8 48970.5 43985.1 44215.6 44972.8 44978.3 45130.8 39290.8 40339.6 40507.8 40554.0 40874.4 6727.7 6776.5 6920.7 7465.8 7610.7 29290.9 30496.0 31033.0 31401.2 31535.7 37350.8 37945.0 38560.6 38564.2 38775.4 9051.2 9616.3 9753.1 9873.8 9963.4 10457.7 10501.2 10615.0 10832.8 10976.4 9560.7 10155.2 10232.0 10358.1 10660.5 10108.9 10124.6 10140.0 10169.2 10324.4 9857.4 10134.0 10376.5 10582.9 10905.9 8341.8 8455.5 8655.5 8805.0 9350.2 8408.8 8710.3 8777.7 8806.9 8950.1 08:40:11 INFO - 2015-12-15 08:40:11,011 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:40:11 INFO - 2015-12-15 08:40:11,011 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-12-15 08:40:11,779 INFO : Browser exited with error code: 0 08:40:11 INFO - 2015-12-15 08:40:11,800 INFO : Completed test dromaeo_css (00:18:37) 08:40:11 INFO - 2015-12-15 08:40:11,800 INFO : Starting test kraken 08:40:11 INFO - 2015-12-15 08:40:11,800 DEBUG : operating with platform_type : linux_ 08:40:11 INFO - 2015-12-15 08:40:11,801 INFO : Initialising browser for kraken test... 08:40:11 INFO - 2015-12-15 08:40:11,807 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihLaGK/profile http://localhost:40236/getInfo.html 08:40:16 INFO - 2015-12-15 08:40:16,320 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:40:16 INFO - 2015-12-15 08:40:16,321 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:40:16 INFO - 2015-12-15 08:40:16,321 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:40:16 INFO - 2015-12-15 08:40:16,321 DEBUG : BROWSER_OUTPUT: __metrics 08:40:16 INFO - 2015-12-15 08:40:16,398 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:40:16 INFO - 2015-12-15 08:40:16,453 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:17 INFO - 2015-12-15 08:40:17,276 INFO : Browser initialized. 08:40:17 INFO - 2015-12-15 08:40:17,277 INFO : Running cycle 1/1 for kraken test... 08:40:17 INFO - 2015-12-15 08:40:17,277 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihLaGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:40:29 INFO - 2015-12-15 08:40:29,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 142483456 08:40:29 INFO - 2015-12-15 08:40:29,216 DEBUG : BROWSER_OUTPUT: 08:40:31 INFO - 2015-12-15 08:40:31,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40236/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:32 INFO - 2015-12-15 08:40:32,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 179539968 08:40:32 INFO - 2015-12-15 08:40:32,407 DEBUG : BROWSER_OUTPUT: 08:40:35 INFO - 2015-12-15 08:40:35,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40236/tests/kraken/driver.html?testName=audio-dft) 08:40:35 INFO - 2015-12-15 08:40:35,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 168583168 08:40:35 INFO - 2015-12-15 08:40:35,708 DEBUG : BROWSER_OUTPUT: 08:40:38 INFO - 2015-12-15 08:40:38,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40236/tests/kraken/driver.html?testName=audio-fft) 08:40:39 INFO - 2015-12-15 08:40:39,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 153825280 08:40:39 INFO - 2015-12-15 08:40:39,285 DEBUG : BROWSER_OUTPUT: 08:40:41 INFO - 2015-12-15 08:40:41,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40236/tests/kraken/driver.html?testName=audio-oscillator) 08:40:41 INFO - 2015-12-15 08:40:41,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 156504064 08:40:41 INFO - 2015-12-15 08:40:41,904 DEBUG : BROWSER_OUTPUT: 08:40:44 INFO - 2015-12-15 08:40:44,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:44 INFO - 2015-12-15 08:40:44,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 156475392 08:40:44 INFO - 2015-12-15 08:40:44,727 DEBUG : BROWSER_OUTPUT: 08:40:47 INFO - 2015-12-15 08:40:47,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40236/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:48 INFO - 2015-12-15 08:40:48,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 158621696 08:40:48 INFO - 2015-12-15 08:40:48,294 DEBUG : BROWSER_OUTPUT: 08:40:51 INFO - 2015-12-15 08:40:51,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40236/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:52 INFO - 2015-12-15 08:40:52,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 157560832 08:40:52 INFO - 2015-12-15 08:40:52,255 DEBUG : BROWSER_OUTPUT: 08:40:55 INFO - 2015-12-15 08:40:55,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40236/tests/kraken/driver.html?testName=json-parse-financial) 08:40:55 INFO - 2015-12-15 08:40:55,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 158633984 08:40:55 INFO - 2015-12-15 08:40:55,728 DEBUG : BROWSER_OUTPUT: 08:40:57 INFO - 2015-12-15 08:40:57,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:58 INFO - 2015-12-15 08:40:58,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 165445632 08:40:58 INFO - 2015-12-15 08:40:58,051 DEBUG : BROWSER_OUTPUT: 08:40:59 INFO - 2015-12-15 08:40:59,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:00 INFO - 2015-12-15 08:41:00,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 165892096 08:41:00 INFO - 2015-12-15 08:41:00,528 DEBUG : BROWSER_OUTPUT: 08:41:02 INFO - 2015-12-15 08:41:02,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:03 INFO - 2015-12-15 08:41:03,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 178741248 08:41:03 INFO - 2015-12-15 08:41:03,251 DEBUG : BROWSER_OUTPUT: 08:41:05 INFO - 2015-12-15 08:41:05,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:06 INFO - 2015-12-15 08:41:06,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 184336384 08:41:06 INFO - 2015-12-15 08:41:06,347 DEBUG : BROWSER_OUTPUT: 08:41:08 INFO - 2015-12-15 08:41:08,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:09 INFO - 2015-12-15 08:41:09,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 178958336 08:41:09 INFO - 2015-12-15 08:41:09,535 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40236/tests/kraken/driver.html?testName=ai-astar) 08:41:11 INFO - 2015-12-15 08:41:11,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 237768704 08:41:11 INFO - 2015-12-15 08:41:11,577 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,577 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:41:11 INFO - 2015-12-15 08:41:11,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;107;112;111;112;100;113;111;112 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;128;152;171;130;151;148;135;175;130 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;162;161;159;161;162;160;162 08:41:11 INFO - 2015-12-15 08:41:11,579 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;72;86;89;74;73;72;106;89;72 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;130;94;95;96;134;94;94;134 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;110;109;109 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;146 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;95 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;72;73;71;72;79;69;69 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;69;69;68;69;69 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;83;83;94;83;82;82;83;83 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;118;117;116;122;121;121;125;120;126 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;147;148;146;149;133;147;145;149;141 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;70;68;70;71;70;70;71;67 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1022 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197671577__endTimestamp 08:41:11 INFO - 2015-12-15 08:41:11,580 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:4.00 (3.6%) stddev-sans-first:4.20 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 107.0 112.0 111.0 112.0 100.0 113.0 111.0 112.0 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:151.50 stddev:17.14 (11.3%) stddev-sans-first:17.62 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: Values: 160.0 128.0 152.0 171.0 130.0 151.0 148.0 135.0 175.0 130.0 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 162.0 161.0 159.0 161.0 162.0 160.0 162.0 08:41:11 INFO - 2015-12-15 08:41:11,584 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:79.00 stddev:11.25 (14.2%) stddev-sans-first:11.90 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: Values: 84.0 72.0 86.0 89.0 74.0 73.0 72.0 106.0 89.0 72.0 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:94.50 stddev:18.31 (19.4%) stddev-sans-first:18.97 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 130.0 94.0 95.0 96.0 134.0 94.0 94.0 134.0 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,585 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:2.79 (3.9%) stddev-sans-first:2.93 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 72.0 73.0 71.0 72.0 79.0 69.0 69.0 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,586 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.60 (4.3%) stddev-sans-first:3.76 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 83.0 83.0 94.0 83.0 82.0 82.0 83.0 83.0 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.00 stddev:3.20 (2.6%) stddev-sans-first:3.39 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: Values: 121.0 118.0 117.0 116.0 122.0 121.0 121.0 125.0 120.0 126.0 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:147.00 stddev:5.77 (3.9%) stddev-sans-first:5.12 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: Values: 135.0 147.0 148.0 146.0 149.0 133.0 147.0 145.0 149.0 141.0 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 68.0 70.0 71.0 70.0 70.0 71.0 67.0 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:41:11 INFO - 2015-12-15 08:41:11,587 DEBUG : BROWSER_OUTPUT: 08:41:12 INFO - 2015-12-15 08:41:12,503 INFO : Browser exited with error code: 0 08:41:12 INFO - 2015-12-15 08:41:12,554 INFO : Completed test kraken (00:01:00) 08:41:12 INFO - 2015-12-15 08:41:12,555 INFO : Starting test v8_7 08:41:12 INFO - 2015-12-15 08:41:12,555 DEBUG : operating with platform_type : linux_ 08:41:12 INFO - 2015-12-15 08:41:12,555 INFO : Initialising browser for v8_7 test... 08:41:12 INFO - 2015-12-15 08:41:12,561 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMvqHiJ/profile http://localhost:40236/getInfo.html 08:41:16 INFO - 2015-12-15 08:41:16,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:41:16 INFO - 2015-12-15 08:41:16,659 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:41:16 INFO - 2015-12-15 08:41:16,659 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:41:16 INFO - 2015-12-15 08:41:16,659 DEBUG : BROWSER_OUTPUT: __metrics 08:41:16 INFO - 2015-12-15 08:41:16,801 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:41:16 INFO - 2015-12-15 08:41:16,861 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:16 ERROR - 2015-12-15 08:41:16,877 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:41:18 INFO - 2015-12-15 08:41:18,031 INFO : Browser initialized. 08:41:18 INFO - 2015-12-15 08:41:18,031 INFO : Running cycle 1/1 for v8_7 test... 08:41:18 INFO - 2015-12-15 08:41:18,031 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMvqHiJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:41:30 INFO - 2015-12-15 08:41:30,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 141844480 08:41:30 INFO - 2015-12-15 08:41:30,068 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40236/tests/v8_7/run.html (next: http://localhost:40236/tests/v8_7/run.html) 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 556654592 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:41:51 INFO - 2015-12-15 08:41:51,847 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |0;Richards;165.94756057085962 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.35855385762207 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |6;Boyer;12107.142857142857 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |8;Splay;889.9773926149209 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:41:51 INFO - 2015-12-15 08:41:51,848 DEBUG : BROWSER_OUTPUT: __startTimestamp1450197711845__endTimestamp 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.95 Median:165.95 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: Values: 165.9 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.36 Median:186.36 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: Values: 186.4 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: Values: 277.5 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,849 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: Values: 5181.3 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: Values: 1972.4 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: Values: 781.9 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12107.14 Median:12107.14 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: Values: 12107.1 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: Values: 27189.2 08:41:51 INFO - 2015-12-15 08:41:51,850 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:889.98 Median:889.98 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: Values: 890.0 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:41:51 INFO - 2015-12-15 08:41:51,851 DEBUG : BROWSER_OUTPUT: 08:41:52 INFO - 2015-12-15 08:41:52,731 INFO : Browser exited with error code: 0 08:41:52 INFO - 2015-12-15 08:41:52,743 INFO : Completed test v8_7 (00:00:40) 08:41:52 INFO - 2015-12-15 08:41:52,748 INFO : Completed test suite (00:20:18) 08:41:52 INFO - 2015-12-15 08:41:52,749 DEBUG : Working with test: dromaeo_css 08:41:52 INFO - 2015-12-15 08:41:52,749 DEBUG : Generating results file: dromaeo_css 08:41:52 INFO - 2015-12-15 08:41:52,749 DEBUG : Working with test: kraken 08:41:52 INFO - 2015-12-15 08:41:52,749 DEBUG : Generating results file: kraken 08:41:52 INFO - 2015-12-15 08:41:52,749 INFO : javascript benchmark 08:41:52 INFO - 2015-12-15 08:41:52,749 DEBUG : Working with test: v8_7 08:41:52 INFO - 2015-12-15 08:41:52,750 DEBUG : Generating results file: v8_7 08:41:52 INFO - 2015-12-15 08:41:52,750 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:52 INFO - 2015-12-15 08:41:52,817 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:41:52 INFO - 2015-12-15 08:41:52,817 DEBUG : process_Request line: dromaeo_css 6364.52 graph.html#tests=[[72,132,35]] 08:41:52 INFO - 2015-12-15 08:41:52,817 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:52 INFO - 2015-12-15 08:41:52,856 DEBUG : process_Request line: kraken 1516.30 graph.html#tests=[[232,132,35]] 08:41:52 INFO - 2015-12-15 08:41:52,856 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:41:57 INFO - 2015-12-15 08:41:57,887 DEBUG : process_Request line: v8_7 19090.35 graph.html#tests=[[230,132,35]] 08:41:57 INFO - 2015-12-15 08:41:57,888 INFO : javascript benchmark 08:41:57 INFO - 2015-12-15 08:41:57,892 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2649.841009539428, 2730.4266104118133, 2736.138116493306, 2751.353431943493, 2751.95872061919, 4529.977350113245, 4644.187267228239, 4755.239161734124, 4782.808687652494, 4792.161371759941, 4668.066386722652, 4690.460597031342, 4802.951970480294, 4804.61563074954, 4805.711657300564, 4377.124575084979, 4388.626966707834, 4409.757463339515, 4458.063806600618, 4494.640428765691, 4414.359917811916, 4459.955400446002, 4484.798184081724, 4492.910141797162, 4521.525239849818, 4204.516480604724, 4253.999999999969, 4310.116426132635, 4326.805293761757, 4370.868873933787, 4319.308910574325, 4368.082702632451, 4381.058072514393, 4384.079343337903, 4407.603315701603, 4156.688248381383, 4324.1567894260315, 4344.196323680129, 4357.782110894443, 4397.824087036514, 4530.501644819067, 4569.086182763461, 4593.19619066662, 4690.812367505296, 4739.265413860857, 5063.341765570489, 5089.592832573422, 5091.159958606825, 5091.821786237501, 5139.331886854685, 4827.131116399047, 5082.2122571001555, 5118.0, 5124.743762811844, 5130.666506677091, 4673.065386922629, 4681.999999999966, 4687.953120468752, 4759.738214398172, 4829.227323628203, 5205.817796377109, 5227.817026404057, 5229.816956406507, 5232.92150617741, 5284.154535274338, 4756.571908528249, 5025.874353141201, 5026.84919452417, 5030.0694371541385, 5079.771410286546, 4967.503249675004, 5025.748712564357, 5038.067957427887, 5083.466236045236, 5102.770375333119, 5043.873903152377, 5074.720890351066, 5078.289039534468, 5084.898302033938, 5135.563477104413, 4808.63935204861, 5052.520010598987, 5056.393232812086, 5056.443791182967, 5062.4684408137355, 4141.399497072907, 4142.2958097123565, 4164.146349998243, 4220.430241917302, 4272.5086615039045, 3686.4713643714044, 3689.0408493791806, 3689.9815500922323, 3716.5168528091717, 3729.701623870084, 4174.853880114181, 4349.934750978738, 4353.3469979503325, 4354.651627869763, 4395.912081758347, 4957.677750946177, 4974.054929563371, 5034.194528875362, 5061.493850614909, 5103.693778373309, 4370.169667763115, 4372.060007098489, 4376.803043863034, 4381.78091095444, 4436.134953684001, 4285.142971405669, 4523.25366314561, 4527.615152712056, 4528.343390208467, 4567.885802854955, 4656.348111264493, 4713.764311784397, 4736.123817093849, 4740.9051818962735, 4792.065547218259, 5080.796768129233, 5087.821926232564, 5090.185570308733, 5092.898142037213, 5143.665661731976, 4672.08894265615, 4803.543663351976, 4806.759662016955, 4810.158222311012, 4854.8786280341865, 4879.121758083579, 4915.926261106158, 4928.334674818853, 4950.752462376939, 4999.775010124626, 5092.567131793839, 5113.360829896263, 5118.41138269089, 5125.538701516882, 5159.0, 4741.668083234141, 4937.259411088366, 4945.035718034948, 4948.0, 4949.9257511138085, 4817.78319975595, 4857.53853383928, 4881.731504767272, 4882.145624515767, 4897.338859253955, 4764.9047019058735, 4776.116418462596, 4777.3072904429355, 4783.617310615073, 4811.927821082617, 4717.315989181481, 4885.560299573055, 4895.877603059952, 4899.265110233494, 4923.433805112458, 4714.9292760609305, 4738.31294462308, 4755.429348478205, 4775.594074503706, 4829.275608658589], "unit": "score", "name": "dojo.html", "value": 4633.479743670538}, {"lowerIsBetter": false, "replicates": [569.3708452160363, 569.9373068962411, 572.4733245414219, 581.3895409819689, 581.9912701309481, 27596.172114836536, 28099.29751756207, 28161.155165345048, 35678.0, 36656.63343366566, 40211.597884021154, 40555.79722101393, 40641.0, 40692.796536017355, 40712.38931416031, 7983.720569780074, 8142.348612111046, 8147.307478864274, 8152.2662960333555, 8153.266206041455, 7052.929470705304, 7143.714251429962, 10124.088832005118, 10373.0, 10409.21930855185, 10142.340747851365, 10245.0, 10247.436390998491, 10263.178945684365, 10279.640212592562, 9833.213342932548, 9897.15874150698, 9921.355111917774, 9923.900760992443, 9925.255605829556, 9950.35322704022, 9973.950130249303, 10012.849807252896, 10099.444530550816, 10104.595816167344, 37089.443658345146, 37507.62492375096, 37521.43717844234, 37573.0, 37596.62403375959, 2856.9285767855763, 2893.8263704177816, 2904.4917139500503, 2917.562365645149, 2918.1245626312234, 28049.298767530974, 28112.859435702896, 28167.436651267064, 28271.57592636112, 29205.123846284434, 2660.8270462419882, 2708.214617760847, 2719.877605507757, 2772.3900741836765, 2777.4583956128563, 219228.0, 219236.0, 219241.0, 219735.0, 219974.0, 49312.26031609457, 50294.0, 53277.200841987404, 53582.0, 53641.0, 63057.68471157615, 64064.67967660132, 64246.0, 64285.0, 64327.35672643307, 12378.195417297848, 12652.43064062101, 12689.682757931125, 12710.237385756884, 12710.872891271154, 8352.081271060179, 8643.265322447662, 9500.097490738368, 9593.232541396672, 9725.805483890425, 18027.0, 18102.90948545249, 18147.0, 18163.54591135206, 18221.54446138857, 7270.781876543606, 7370.852582948311, 7540.341124952502, 7551.358134558624, 7565.659545320474, 821.2731732416854, 889.7953470701775, 957.8134402211945, 970.7184916374314, 1011.7976404718938, 26401.207963761117, 26481.74905133085, 26913.0, 26924.192274231806, 26945.595816062774, 939.1594522901964, 971.3637567393368, 973.4354074636693, 993.1260490768078, 1066.919981001428, 13704.177749334873, 13953.790693139612, 14853.48012819546, 14886.404543818126, 15107.39570417193, 300357.0, 300358.0, 302442.0, 302844.0, 305125.0, 48229.0, 48493.0, 48696.75651621719, 48758.26862597064, 48800.26799598009, 1233.2353940556911, 1240.7518496300777, 1240.8076748104058, 1247.1457051919465, 1251.4431078170128, 27485.0, 28511.0, 28772.0, 28922.566161507173, 29033.564496532992, 41063.38404923988, 41535.58464415317, 41575.168496629296, 41610.37584436296, 41631.167376652906, 242779.0, 245574.0, 246569.0, 246659.0, 247404.0, 25214.24357269285, 25625.796775403076, 29043.7095629041, 29179.562306565844, 29329.266768330963, 33924.49113263254, 34219.65780342264, 34265.314693705484, 34739.305213896085, 34856.82571587126, 28874.711252887202, 29256.414871702873, 29260.707392926648, 29546.704532954394, 29856.25359366033, 28124.0, 31135.532967005965, 31674.841625791723, 31692.683073169894, 32428.513572296906, 29530.557041643962, 29875.253118672208, 29905.401891962472, 35042.649573503935, 35677.82161089178, 27705.0, 29586.556201656564, 30318.393632127674, 31933.882314118895, 34732.65267347294, 23197.304080877602, 23562.882185588962, 26702.332441689112, 26822.0, 26931.596026060015], "unit": "score", "name": "ext.html", "value": 17041.34046334227}, {"lowerIsBetter": false, "replicates": [333.3632761425676, 334.25794735686765, 337.7652531490612, 338.5936875749101, 341.1199106305731, 8448.91551084489, 8728.738137855858, 10400.323978941373, 14756.6310842229, 15138.864585156116, 14891.478798242064, 15288.464903728373, 15488.457903973363, 16290.42983495578, 16293.266802993865, 4562.156001139783, 5594.216809646653, 5774.393688662672, 5802.216700745409, 5817.650940943536, 5821.214136091616, 5866.911996320037, 5867.562447200442, 5869.060950247961, 5876.559258055641, 5718.914216286759, 5843.918875008138, 5849.473547380735, 5849.7660093596205, 5855.76576936922, 5691.743871525791, 5719.885602287931, 5727.312722473288, 5728.42715728428, 5736.368999410082, 5391.568674506069, 5571.637843540157, 5573.5819813514145, 5579.218909352694, 5582.8325150245555, 20803.06386212624, 20901.477463063544, 20980.790192098037, 21037.89481052585, 21420.25029123989, 1956.4424139120283, 2092.7070210170587, 2095.758987716402, 2102.0, 2128.7658357580654, 13765.862341376558, 13850.09974351664, 13866.722665546733, 14016.719665606734, 14149.85850141506, 1901.2204995951593, 1929.0836852495092, 1930.4691209917244, 1989.34351663952, 1995.860289779716, 56524.43475565233, 63337.683311583605, 64917.0, 64923.35076649267, 65080.3491965079, 15003.399864005536, 15325.157116358485, 15351.846481535265, 15356.616084597974, 15363.846361536242, 18552.165152568166, 19153.233870645297, 20112.69267497608, 23173.188938387077, 23183.0, 7757.806054848561, 7909.288164065147, 8214.383921205934, 8282.751517454486, 8287.254147126787, 6772.966135169293, 6788.253292137861, 6812.659367031629, 6827.69275382609, 6866.038754574363, 7517.436192285601, 7521.398288136936, 7530.246975302426, 7536.886946695804, 7548.999515128496, 2859.9857000714865, 2929.692382299828, 2940.9411811763644, 2964.8517574121206, 2974.3159073413235, 814.8288859339486, 904.9864252036225, 908.6229214875884, 934.5047125023748, 995.9253056020827, 14907.329170187368, 15305.928584999167, 15720.528384148494, 15866.44467443634, 16166.35334586627, 829.8092237639007, 838.86997515384, 865.3034307382618, 882.7837179890839, 884.6947803007952, 7211.411156353763, 7533.924660753432, 8440.238695662956, 8763.780905477413, 8873.600687969058, 467806.0, 471132.0, 477214.0, 479060.0, 483516.0, 60988.39011609916, 62345.68827155926, 62442.687786561684, 64379.35620643827, 75487.62256188683, 932.14242896534, 1068.6855168143072, 1082.188358730936, 1128.915331350152, 1131.3947038334616, 13597.79603305971, 14618.713299731295, 14678.559643210721, 14697.118172909659, 14844.035137716013, 29844.70155298506, 30496.542551862185, 30788.53817192789, 31264.687353126177, 31466.213344666565, 38404.80797595994, 40243.597564023985, 42716.57283427126, 43522.78238608786, 44199.33700994552, 8806.691765788166, 8961.23829474502, 9246.722598322061, 9256.07439256069, 9263.53682315895, 16118.838811612202, 16192.352305907632, 16303.103329317002, 16472.752908706618, 16989.40537081196, 13604.319784010957, 13855.653608659864, 13999.44002239899, 14091.788623170865, 14099.718005640036, 13458.663533411744, 13670.93164534171, 13762.174269543859, 13980.580582582132, 14175.22036288014, 13384.130031547918, 14187.219702916438, 14223.502177423741, 14621.342039608457, 14664.120152790867, 8946.507942063248, 9088.09119088086, 9094.408863423856, 9167.44995300284, 9170.174684278447, 13370.799438008244, 13496.0, 13684.178949263076, 14124.50564230247, 14257.928710356382], "unit": "score", "name": "jquery.html", "value": 9097.630609808206}, {"lowerIsBetter": false, "replicates": [1397.084909384353, 1404.7682132448147, 1416.9929150354253, 1620.2546828458908, 1685.334292954283, 5739.0, 6983.196932352781, 7164.319389657987, 7166.211716711157, 7179.533330333525, 7020.894686579705, 7152.0, 7176.461765367605, 7178.0, 7206.0, 1706.991465042673, 1725.4737305121996, 2030.0966070098812, 2046.2122082998042, 2076.896155192242, 2059.907304171308, 2060.453979695382, 2062.845286603503, 2067.0904801887195, 2067.6588362920174, 2032.5833204193104, 2046.2122082998003, 2098.7586427560796, 2101.023024293703, 2103.432073340205, 2016.7075774012685, 2026.2907982206257, 2042.0198304813623, 2050.569380430104, 2058.2281644383356, 2076.283682129663, 2093.979060209409, 2096.15105882118, 2096.7693553709078, 2098.4019554426914, 7247.31150540703, 7334.193238743734, 7343.192248852622, 7346.228645992147, 7351.77944661661, 3953.8418463261437, 4017.2568074905944, 4029.6977726670616, 4044.69664775143, 4049.8785036448953, 2657.4419371931917, 2689.421774318531, 2743.43759529296, 2745.23133522614, 2747.2719729271757, 821.2526600793309, 827.6606591297539, 833.1085738260064, 862.8791969124328, 865.0614083719172, 9710.514474276328, 9710.6115755369, 9722.75693107678, 9741.123298903061, 9741.853872191923, 3817.560980487224, 3873.748206366577, 3997.8001099944886, 4000.899977500586, 4004.2992476316526, 8398.622062007224, 8415.200555947175, 8417.747467575982, 8425.115362886809, 8436.409451338348, 4173.08192197716, 4184.121334519724, 4186.413902053715, 4188.434561334242, 4189.958100419018, 3761.1725420407465, 3788.4696142540065, 3788.6969042476535, 3799.810009499514, 3800.562935262425, 3053.5724998500227, 3110.3001824589737, 3316.403047451434, 3359.8320083995704, 3499.772514786531, 1093.147345070846, 1100.510272928539, 1122.1639878290725, 1128.565502281611, 1136.5226604825828, 940.7930255343813, 942.0673533202081, 1000.7348052766023, 1022.9181665466893, 1203.5967950736601, 6849.383555480031, 6883.380495755406, 6904.067950826675, 6906.758263460855, 6909.619970901548, 963.272729089533, 973.3138137612966, 999.9950000249952, 1054.9208809339177, 1075.6665433715416, 5372.462753724596, 5420.972895135578, 5425.0, 5438.15708565173, 5438.728063596884, 8484.745457636282, 8543.145685431531, 8650.43772154808, 8714.172153645393, 8775.517346545874, 8608.09614990417, 8682.262007729414, 8688.087750786077, 8704.738857834149, 8707.695230666895, 6731.259561448237, 6782.389584937379, 6819.352161544645, 6893.586384816927, 6936.895946560705, 6564.081028656087, 6576.671166441563, 6578.144841170617, 6583.177102862142, 6591.571547849375, 7522.210167932507, 7733.110692270461, 7749.41879359039, 7784.41616878725, 7785.805354865947, 7811.414143939113, 7856.135825059125, 8045.396595255263, 8127.959360203161, 8130.2682758549645, 6412.61524308543, 6414.454771344302, 6466.644334561644, 6481.0, 6481.902771458337, 5501.229827824188, 5644.294463192101, 6478.611283323015, 6719.0, 6977.372036516738, 6259.687015649109, 6283.2774230962195, 6297.874042519215, 6379.234491861006, 6395.968020159869, 6129.417705317987, 6298.71655775482, 6426.775062872777, 6428.6785660717715, 6655.201375834931, 6482.092507048923, 6489.513286503626, 6492.091107245084, 6499.6750162492635, 6516.837079073061, 6033.78881739137, 6065.090236464565, 6073.605215660968, 6078.483328916915, 6086.2087928569, 5865.384134665798, 6121.3572574879, 6171.228596425447, 6178.474829639351, 6215.627062376272], "unit": "score", "name": "mootools.html", "value": 4087.1453023653808}, {"lowerIsBetter": false, "replicates": [289.47171412172787, 294.20564475915023, 298.31238994118564, 299.07734638639795, 299.5237572260106, 5270.183121616151, 5302.4697530247, 5307.628466007381, 5311.0, 5321.547668448186, 5024.723640199788, 5060.6204534659955, 5155.149400348947, 5238.685678859271, 5256.763445644946, 4097.344424892018, 4110.588941105895, 4120.25835349637, 4124.133931874302, 4129.793510324472, 3888.1251718363283, 4114.19773144237, 4115.979420102895, 4123.9381409278885, 4129.236091323115, 3954.5254569451704, 4004.479417675698, 4099.856505022325, 4114.7119701620895, 4114.876553703393, 4077.7757223352705, 4087.4073259377224, 4089.591040895916, 4091.099958009248, 4103.466549348595, 3588.4976103345552, 3604.1350075981836, 3611.205534782344, 3616.385214513539, 3619.1133172372674, 5129.820456284049, 5141.357330333708, 5142.202958541432, 5147.871303217412, 5148.330717006803, 4502.977485112586, 4636.165490211761, 4641.907161856744, 4648.721076735373, 4697.224957881946, 5555.3333599967855, 5569.359523654791, 5570.777168913239, 5571.164325351189, 5572.832815015556, 3813.31360355136, 3817.675497582709, 3826.1773718650625, 3829.8276577554075, 3830.425436184567, 5765.769369225226, 5812.767489300465, 5824.534037277008, 5826.533877289807, 5840.328362238354, 3789.1629938376223, 3863.74885632433, 3919.6080391960577, 3922.764634121962, 3938.4092386141733, 3976.7812770297332, 3977.125032492847, 3979.184267225212, 3983.5618082010956, 3983.820728067244, 4566.931496027496, 4575.450945886515, 4584.266517357207, 4584.908301833944, 4604.746738929391, 5555.333359996826, 5560.193771903051, 5562.972185139049, 5567.8886422272135, 5577.776888924479, 1369.5685858954398, 1373.7801951687882, 1396.294871090093, 1398.9090709103875, 1400.7128538649552, 924.505389616552, 944.5230158769778, 947.303731757158, 953.618552578974, 954.2270760683869, 4835.854924352205, 4869.9513004870205, 4876.439209490883, 4878.0975519529, 4879.926801097987, 5779.942200578024, 5788.0739081746715, 5789.9710501447225, 5791.536677065825, 5793.768249270066, 4701.388819453449, 4794.065157294364, 4797.880052998633, 4871.610271178297, 4918.458969513351, 3107.90676279712, 3117.1895307220284, 3127.4526957782296, 3132.483140281828, 3138.4350816853184, 5462.071447853875, 5474.863128421742, 5477.808276710296, 5482.835514934558, 5491.588130890199, 5823.79616713413, 5971.164037034819, 5973.581849270597, 5974.671393073336, 5978.701064946822, 5492.945070549324, 5493.121100623881, 5498.615096943256, 5501.834944951578, 5510.338759348904, 5846.883062338815, 5852.970735146297, 5854.648721076749, 5858.765649373977, 5860.443257890493, 5717.942820571741, 5728.570357223141, 5730.627509212055, 5731.971340143273, 5741.25363702716, 5363.410024897336, 5501.477359650827, 5507.421720719267, 5511.255980442589, 5512.91730624033, 3911.647951684362, 3942.2706799242233, 3947.0921688011344, 3953.169834334822, 3956.8615098471414, 5831.94168058314, 5839.678817665069, 5840.532757379485, 5841.591088623755, 5842.38654941225, 5454.4545545445135, 5620.634658747168, 5625.634333768292, 5631.521320687787, 5635.154726791015, 5587.664740115606, 5592.69240191777, 5596.132599447093, 5599.160125980972, 5608.747606357805, 5481.095619222943, 5484.753186106555, 5487.506124448819, 5488.094464413327, 5495.203195536545, 5634.0, 5643.068893632505, 5646.548276137817, 5647.463490968352, 5651.632643878134, 5384.703841288767, 5491.478309560745, 5502.8349149525575, 5506.752196151263, 5515.172724091419], "unit": "score", "name": "prototype.html", "value": 4170.27289914584}, {"lowerIsBetter": false, "replicates": [701.582558377765, 740.988885166723, 745.0649434959125, 774.6320497763561, 783.8471498057879, 10908.400037997917, 11080.05819505343, 11089.05743011843, 11091.389973551462, 11131.109511239101, 11161.83257251142, 11203.103751699864, 11246.100311975042, 11268.211225214238, 11276.492557834896, 616.2697203813473, 623.1276213301392, 763.7479631721533, 764.7667461424263, 781.9335356494705, 772.4399810137661, 773.8529679360931, 781.679511400326, 782.2060608482395, 783.4594130050247, 642.2068745099822, 815.7104227999064, 823.7858156879195, 823.8764185372182, 824.2416976381713, 647.8963365861463, 803.7669075967963, 817.3461231015164, 817.546261824687, 817.5830326533481, 603.5865432178972, 606.4935778624854, 606.7754930675678, 609.0194786393902, 609.454538188319, 10730.785384292349, 10778.137748980063, 10830.0, 10849.566017359297, 10893.237473376867, 10362.585496580203, 10550.15598752098, 10720.678379648623, 10781.245312828105, 10849.837252441219, 8725.607347669371, 8820.0, 9073.818523629556, 9094.545272736337, 9221.262299016063, 3231.74146068314, 3262.4943133814295, 3291.555639988595, 3317.10438181692, 3384.272381437978, 37724.43413348802, 37953.62046379556, 38053.619463805284, 38065.61934380649, 38172.0, 7910.16943220965, 8140.75577732669, 8323.1260717625, 8425.0, 8617.922759655043, 14117.08238964464, 14135.293235338191, 14169.858301416854, 14193.574192774233, 14244.07413518118, 6211.782587609412, 6250.656213908279, 6360.6501642409185, 6474.546781725328, 6504.5121615879, 3343.348047130835, 3418.418868792311, 3441.483777433405, 3446.5347178130633, 3454.084667563098, 2575.729548397429, 2605.4398304364654, 2608.9478210435686, 2610.973890261111, 2612.5166844133896, 452.6265830689694, 460.8709561322835, 468.7820163623931, 471.66747443052566, 474.0542617478153, 467.67262915958963, 470.82344120954644, 486.65190456049703, 512.5720023780111, 548.1667864845413, 6942.479314051467, 6975.093237879043, 7014.789556313319, 7164.176119746192, 7186.928130718626, 434.3137842209302, 481.379021062832, 528.4213785904428, 539.4120408754477, 547.6960287040731, 3206.8075915445147, 3231.0629917323713, 3246.9188270292957, 3348.330333933174, 3349.43059679855, 47866.0, 48612.0, 48901.266481002815, 48937.75531122321, 48970.510294896594, 43985.12029759387, 44215.55784442179, 44972.77513612411, 44978.325325120146, 45130.77434612872, 39290.80354598266, 40339.596604033584, 40507.79746101251, 40554.0, 40874.38688419676, 6727.663616819237, 6776.525643204928, 6920.688569014507, 7465.776026719207, 7610.733624323122, 29290.853545732134, 30496.0, 31033.0, 31401.214969625944, 31535.684643153276, 37350.75895446282, 37945.0, 38560.6143938557, 38564.22871542497, 38775.418368725055, 9051.185393314634, 9616.326857119935, 9753.073458021476, 9873.802523949336, 9963.352382095141, 10457.68626941193, 10501.159907207253, 10614.991575800286, 10832.837507437238, 10976.396298203355, 9560.713178604654, 10155.187584993035, 10232.0, 10358.067773900386, 10660.46697665129, 10108.898911010796, 10124.645637402655, 10140.0, 10169.237307201842, 10324.43215623118, 9857.408555486694, 10134.0, 10376.465665813275, 10582.894171058191, 10905.890941090805, 8341.791455213668, 8455.492670439793, 8655.48067115975, 8805.0, 9350.205232555309, 8408.83182336362, 8710.259627931697, 8777.736667899973, 8806.86789698168, 8950.14973577509], "unit": "score", "name": "yui.html", "value": 5427.792422225836}], "name": "dromaeo_css", "value": 6364.522687985682}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 107.0, 112.0, 111.0, 112.0, 100.0, 113.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 152.0, 171.0, 130.0, 151.0, 148.0, 135.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 159.0, 161.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [84.0, 72.0, 86.0, 89.0, 74.0, 73.0, 72.0, 106.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 130.0, 94.0, 95.0, 96.0, 134.0, 94.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 73.0, 71.0, 72.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 83.0, 94.0, 83.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 117.0, 116.0, 122.0, 121.0, 121.0, 125.0, 120.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [135.0, 147.0, 148.0, 146.0, 149.0, 133.0, 147.0, 145.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 68.0, 70.0, 71.0, 70.0, 70.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1516.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.94756057085962], "unit": "score", "name": "Richards", "value": 212.72985200000008}, {"lowerIsBetter": false, "replicates": [186.35855385762207], "unit": "score", "name": "DeltaBlue", "value": 354.7891880000001}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12107.142857142857], "unit": "score", "name": "Boyer", "value": 55.04709144542769}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [889.9773926149209], "unit": "score", "name": "Splay", "value": 91.56524724809482}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19090.34656103124}]} 08:41:57 INFO - RETURN: dromaeo_css: 6364.52 08:41:57 INFO - RETURN: kraken: 1516.30 08:41:57 INFO - RETURN: v8_7: 19090.35 08:41:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19090.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6364.52"}}} 08:41:57 INFO - Return code: 0 08:41:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:41:58 ERROR - # TBPL SUCCESS # 08:41:58 INFO - Running post-action listener: _resource_record_post_action 08:41:58 INFO - Running post-run listener: _resource_record_post_run 08:41:59 INFO - Total resource usage - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509026304; Read time: 12; Write time: 573228 08:41:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232140800; Read time: 0; Write time: 392636 08:41:59 INFO - run-tests - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276881408; Read time: 12; Write time: 180592 08:41:59 INFO - Running post-run listener: _upload_blobber_files 08:41:59 INFO - Blob upload gear active. 08:41:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:41:59 INFO - Copying logs to upload dir... 08:41:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.306866 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-15 08:41:59.122260) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:59.125778) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009826 build_url: 'https://queue.taskcluster.net/v1/task/hnECIkjbTniOcazqsiamTg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:59.178005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:59.178497) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450196049.452008-1999407219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 08:41:59.228705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 08:41:59.229049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 08:41:59.229515) ========= ========= Total master_lag: 0.25 =========